builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1495386261.72 results: success (0) revision: b31a663614e8df7876563e03c4735aa5c8a38f5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.722880) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.723418) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.723723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.740188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.740539) ========= 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=8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-21 10:04:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 140M=0s 2017-05-21 10:04:21 (140 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.889408) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.889729) ========= 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=8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023308 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:21.940549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-21 10:04:21.943928) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b31a663614e8df7876563e03c4735aa5c8a38f5a --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 b31a663614e8df7876563e03c4735aa5c8a38f5a --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=8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-21 10:04:22,010 truncating revision to first 12 chars 2017-05-21 10:04:22,010 Setting DEBUG logging. 2017-05-21 10:04:22,010 attempt 1/10 2017-05-21 10:04:22,010 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b31a663614e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-21 10:04:23,089 unpacking tar archive at: mozilla-central-b31a663614e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.465586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-21 10:04:23.421744) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:23.425179) ========= script_repo_revision: b31a663614e8df7876563e03c4735aa5c8a38f5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:23.425577) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:23.425867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 10:04:23.434805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-21 10:04:23.435198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:23 INFO - MultiFileLogger online at 20170521 10:04:23 in /builds/slave/test 10:04:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:04:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:23 INFO - {'append_to_log': False, 10:04:23 INFO - 'base_work_dir': '/builds/slave/test', 10:04:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:04:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:23 INFO - 'branch': 'Firefox-Non-PGO', 10:04:23 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:23 INFO - 'config_files': ('talos/linux_config.py',), 10:04:23 INFO - 'default_actions': ('clobber', 10:04:23 INFO - 'read-buildbot-config', 10:04:23 INFO - 'download-and-extract', 10:04:23 INFO - 'populate-webroot', 10:04:23 INFO - 'create-virtualenv', 10:04:23 INFO - 'install', 10:04:23 INFO - 'run-tests'), 10:04:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:23 INFO - 'download_minidump_stackwalk': True, 10:04:23 INFO - 'download_symbols': 'ondemand', 10:04:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:23 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:23 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:23 INFO - 'gecko_profile': False, 10:04:23 INFO - 'gecko_profile_interval': 0, 10:04:23 INFO - 'installer_path': 'installer.exe', 10:04:23 INFO - 'log_level': 'info', 10:04:23 INFO - 'log_name': 'talos', 10:04:23 INFO - 'log_to_console': True, 10:04:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:23 INFO - 'opt_config_files': (), 10:04:23 INFO - 'pip_index': False, 10:04:23 INFO - 'suite': 'dromaeojs-e10s', 10:04:23 INFO - 'system_bits': '32', 10:04:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:23 INFO - 'title': 'talos-linux64-ix-038', 10:04:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:23 INFO - 'use_talos_json': True, 10:04:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:23 INFO - 'work_dir': 'build'} 10:04:23 INFO - [mozharness: 2017-05-21 17:04:23.603252Z] Running clobber step. 10:04:23 INFO - Running pre-action listener: _resource_record_pre_action 10:04:23 INFO - Running main action method: clobber 10:04:23 INFO - rmtree: /builds/slave/test/build 10:04:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:24 INFO - Running post-action listener: _resource_record_post_action 10:04:24 INFO - [mozharness: 2017-05-21 17:04:24.620930Z] Finished clobber step (success) 10:04:24 INFO - [mozharness: 2017-05-21 17:04:24.621031Z] Running read-buildbot-config step. 10:04:24 INFO - Running pre-action listener: _resource_record_pre_action 10:04:24 INFO - Running main action method: read_buildbot_config 10:04:24 INFO - Using buildbot properties: 10:04:24 INFO - { 10:04:24 INFO - "project": "", 10:04:24 INFO - "product": "firefox", 10:04:24 INFO - "who": "philringnalda@gmail.com", 10:04:24 INFO - "installer_path": "public/build/target.tar.bz2", 10:04:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:04:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:04:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:04:24 INFO - "stage_platform": "linux64", 10:04:24 INFO - "basedir": "/builds/slave/test", 10:04:24 INFO - "buildnumber": 620, 10:04:24 INFO - "platform": "ubuntu64_hw", 10:04:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:04:24 INFO - "slavebuilddir": "test", 10:04:24 INFO - "taskId": "PXYo2mUdTI-2uNhyikPt-w", 10:04:24 INFO - "branch": "mozilla-central", 10:04:24 INFO - "script_repo_revision": "production", 10:04:24 INFO - "revision": "b31a663614e8df7876563e03c4735aa5c8a38f5a", 10:04:24 INFO - "slavename": "talos-linux64-ix-038", 10:04:24 INFO - "repo_path": "mozilla-central" 10:04:24 INFO - } 10:04:24 INFO - Finding installer, test and symbols from parent task. 10:04:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXYo2mUdTI-2uNhyikPt-w'}, attempt #1 10:04:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PXYo2mUdTI-2uNhyikPt-w'}, attempt #1 10:04:25 INFO - Task dependencies: PWFcMnYUSCCOcLDu6SCchg 10:04:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg'}, attempt #1 10:04:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2 10:04:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/test_packages.json 10:04:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.crashreporter-symbols.zip 10:04:25 INFO - Running post-action listener: _resource_record_post_action 10:04:25 INFO - [mozharness: 2017-05-21 17:04:25.963898Z] Finished read-buildbot-config step (success) 10:04:25 INFO - [mozharness: 2017-05-21 17:04:25.964192Z] Running download-and-extract step. 10:04:25 INFO - Running pre-action listener: _resource_record_pre_action 10:04:25 INFO - Running main action method: download_and_extract 10:04:25 INFO - mkdir: /builds/slave/test/build/tests 10:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:25 INFO - trying https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.test_packages.json 10:04:25 INFO - Downloading https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:04:26 INFO - Downloaded 986 bytes. 10:04:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:04:26 INFO - Using the following test package requirements: 10:04:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:04:26 INFO - u'common': [u'target.common.tests.zip'], 10:04:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:04:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:04:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:04:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:04:26 INFO - u'mozbase': [u'target.common.tests.zip'], 10:04:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:04:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:04:26 INFO - u'web-platform': [u'target.common.tests.zip', 10:04:26 INFO - u'target.web-platform.tests.zip'], 10:04:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:04:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:04:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.common.tests.zip 10:04:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:04:26 INFO - Fetch https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.common.tests.zip into memory 10:04:28 INFO - Content-Length response header: 63520795 10:04:28 INFO - Bytes received: 63520795 10:04:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:04:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.common.tests.zip 10:04:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:04:39 INFO - Fetch https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.common.tests.zip into memory 10:04:40 INFO - Content-Length response header: 63520795 10:04:40 INFO - Bytes received: 63520795 10:04:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.talos.tests.zip 10:04:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:04:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.talos.tests.zip into memory 10:04:52 INFO - Content-Length response header: 14410000 10:04:52 INFO - Bytes received: 14410000 10:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:53 INFO - trying https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2 10:04:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:04:54 INFO - Downloaded 54840422 bytes. 10:04:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2 10:04:54 INFO - mkdir: /builds/slave/test/properties 10:04:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:04:54 INFO - Writing to file /builds/slave/test/properties/build_url 10:04:54 INFO - Contents: 10:04:54 INFO - build_url:https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2 10:04:54 INFO - Running post-action listener: _resource_record_post_action 10:04:54 INFO - Running post-action listener: set_extra_try_arguments 10:04:54 INFO - [mozharness: 2017-05-21 17:04:54.716307Z] Finished download-and-extract step (success) 10:04:54 INFO - [mozharness: 2017-05-21 17:04:54.716404Z] Running populate-webroot step. 10:04:54 INFO - Running pre-action listener: _resource_record_pre_action 10:04:54 INFO - Running main action method: populate_webroot 10:04:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:54 INFO - '--tppagecycles', 10:04:54 INFO - '7'], 10:04:54 INFO - 'tests': ['tsvgm']}}, 10:04:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:04:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:04:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:04:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['damp', 'tps']}, 10:04:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'tests': ['damp', 'tps']}, 10:04:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['dromaeo_dom']}, 10:04:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:04:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:04:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'tests': ['ts_paint', 'tp5o']}, 10:04:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other-e10s': {'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['a11yr', 10:04:54 INFO - 'ts_paint', 10:04:54 INFO - 'tpaint', 10:04:54 INFO - 'sessionrestore', 10:04:54 INFO - 'sessionrestore_no_auto_restore', 10:04:54 INFO - 'tabpaint']}, 10:04:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:04:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:04:54 INFO - 'bloom_basic_ref']}, 10:04:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tsvgx', 10:04:54 INFO - 'tsvgr_opacity', 10:04:54 INFO - 'tart', 10:04:54 INFO - 'tscrollx', 10:04:54 INFO - 'cart', 10:04:54 INFO - 'tsvg_static']}, 10:04:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:04:54 INFO - 'tsvgr_opacity', 10:04:54 INFO - 'tart', 10:04:54 INFO - 'tscrollx', 10:04:54 INFO - 'cart', 10:04:54 INFO - 'tsvg_static']}, 10:04:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s'], 10:04:54 INFO - 'tests': ['tp5o']}, 10:04:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:04:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'talos_options': ['--disable-e10s', 10:04:54 INFO - '--xperf_path', 10:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:54 INFO - 'tests': ['tp5n']}, 10:04:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:04:54 INFO - 'talos_options': ['--xperf_path', 10:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:54 INFO - 'tests': ['tp5n']}}, 10:04:54 INFO - 'talos.zip': {'path': '', 10:04:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:54 INFO - Running post-action listener: _resource_record_post_action 10:04:54 INFO - [mozharness: 2017-05-21 17:04:54.730395Z] Finished populate-webroot step (success) 10:04:54 INFO - [mozharness: 2017-05-21 17:04:54.730483Z] Running create-virtualenv step. 10:04:54 INFO - Running pre-action listener: _resource_record_pre_action 10:04:54 INFO - Running main action method: create_virtualenv 10:04:54 INFO - Creating virtualenv /builds/slave/test/build/venv 10:04:54 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 10:04:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:54 INFO - Using real prefix '/usr' 10:04:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:04:55 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:57 INFO - Installing pip.................done. 10:04:57 INFO - Return code: 0 10:04:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:04:57 INFO - Reading from file tmpfile_stdout 10:04:57 INFO - Output received: 10:04:57 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) 10:04:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:57 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:04:57 INFO - Using env: {'DISPLAY': ':0', 10:04:57 INFO - 'HOME': '/home/cltbld', 10:04:57 INFO - 'LANG': 'en_US.UTF-8', 10:04:57 INFO - 'LANGUAGE': 'en_US:en', 10:04:57 INFO - 'LOGNAME': 'cltbld', 10:04:57 INFO - 'MAIL': '/var/mail/cltbld', 10:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:57 INFO - 'MOZ_NO_REMOTE': '1', 10:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:57 INFO - 'NO_EM_RESTART': '1', 10:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:57 INFO - 'PWD': '/builds/slave/test', 10:04:57 INFO - 'SHELL': '/bin/bash', 10:04:57 INFO - 'SHLVL': '1', 10:04:57 INFO - 'TERM': 'linux', 10:04:57 INFO - 'TMOUT': '86400', 10:04:57 INFO - 'USER': 'cltbld', 10:04:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:57 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 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 10:04:57 INFO - Cleaning up... 10:04:57 INFO - Return code: 0 10:04:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:57 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:04:57 INFO - Using env: {'DISPLAY': ':0', 10:04:57 INFO - 'HOME': '/home/cltbld', 10:04:57 INFO - 'LANG': 'en_US.UTF-8', 10:04:57 INFO - 'LANGUAGE': 'en_US:en', 10:04:57 INFO - 'LOGNAME': 'cltbld', 10:04:57 INFO - 'MAIL': '/var/mail/cltbld', 10:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:57 INFO - 'MOZ_NO_REMOTE': '1', 10:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:57 INFO - 'NO_EM_RESTART': '1', 10:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:57 INFO - 'PWD': '/builds/slave/test', 10:04:57 INFO - 'SHELL': '/bin/bash', 10:04:57 INFO - 'SHLVL': '1', 10:04:57 INFO - 'TERM': 'linux', 10:04:57 INFO - 'TMOUT': '86400', 10:04:57 INFO - 'USER': 'cltbld', 10:04:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:57 INFO - '_': '/tools/buildbot/bin/python'} 10:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:57 INFO - Downloading/unpacking psutil>=3.1.1 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:59 INFO - Installing collected packages: psutil 10:04:59 INFO - Running setup.py install for psutil 10:04:59 INFO - building 'psutil._psutil_linux' extension 10:04:59 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 10:04:59 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 10:04:59 INFO - building 'psutil._psutil_posix' extension 10:04:59 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 10:04:59 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 10:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:59 INFO - Successfully installed psutil 10:04:59 INFO - Cleaning up... 10:04:59 INFO - Return code: 0 10:04:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:04:59 INFO - Using env: {'DISPLAY': ':0', 10:04:59 INFO - 'HOME': '/home/cltbld', 10:04:59 INFO - 'LANG': 'en_US.UTF-8', 10:04:59 INFO - 'LANGUAGE': 'en_US:en', 10:04:59 INFO - 'LOGNAME': 'cltbld', 10:04:59 INFO - 'MAIL': '/var/mail/cltbld', 10:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:59 INFO - 'MOZ_NO_REMOTE': '1', 10:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:59 INFO - 'NO_EM_RESTART': '1', 10:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:59 INFO - 'PWD': '/builds/slave/test', 10:04:59 INFO - 'SHELL': '/bin/bash', 10:04:59 INFO - 'SHLVL': '1', 10:04:59 INFO - 'TERM': 'linux', 10:04:59 INFO - 'TMOUT': '86400', 10:04:59 INFO - 'USER': 'cltbld', 10:04:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:59 INFO - '_': '/tools/buildbot/bin/python'} 10:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:00 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 10:05:00 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 10:05:00 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 10:05:00 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 10:05:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:01 INFO - Installing collected packages: mozsystemmonitor 10:05:01 INFO - Running setup.py install for mozsystemmonitor 10:05:01 INFO - Successfully installed mozsystemmonitor 10:05:01 INFO - Cleaning up... 10:05:01 INFO - Return code: 0 10:05:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:01 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:05:01 INFO - Using env: {'DISPLAY': ':0', 10:05:01 INFO - 'HOME': '/home/cltbld', 10:05:01 INFO - 'LANG': 'en_US.UTF-8', 10:05:01 INFO - 'LANGUAGE': 'en_US:en', 10:05:01 INFO - 'LOGNAME': 'cltbld', 10:05:01 INFO - 'MAIL': '/var/mail/cltbld', 10:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:01 INFO - 'MOZ_NO_REMOTE': '1', 10:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:01 INFO - 'NO_EM_RESTART': '1', 10:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:01 INFO - 'PWD': '/builds/slave/test', 10:05:01 INFO - 'SHELL': '/bin/bash', 10:05:01 INFO - 'SHLVL': '1', 10:05:01 INFO - 'TERM': 'linux', 10:05:01 INFO - 'TMOUT': '86400', 10:05:01 INFO - 'USER': 'cltbld', 10:05:01 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:01 INFO - '_': '/tools/buildbot/bin/python'} 10:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:01 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:01 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 10:05:01 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 10:05:01 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 10:05:01 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 10:05:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:02 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 10:05:02 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 10:05:02 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 10:05:02 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 10:05:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:02 INFO - warning: no files found matching '*.txt' 10:05:02 INFO - no previously-included directories found matching 'build' 10:05:02 INFO - no previously-included directories found matching 'dist' 10:05:02 INFO - no previously-included directories found matching '.git*' 10:05:02 INFO - Installing collected packages: jsonschema, functools32 10:05:02 INFO - Running setup.py install for functools32 10:05:02 INFO - warning: no files found matching '*.txt' 10:05:02 INFO - no previously-included directories found matching 'build' 10:05:02 INFO - no previously-included directories found matching 'dist' 10:05:02 INFO - no previously-included directories found matching '.git*' 10:05:02 INFO - Successfully installed jsonschema functools32 10:05:02 INFO - Cleaning up... 10:05:03 INFO - Return code: 0 10:05:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:03 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:05:03 INFO - Using env: {'DISPLAY': ':0', 10:05:03 INFO - 'HOME': '/home/cltbld', 10:05:03 INFO - 'LANG': 'en_US.UTF-8', 10:05:03 INFO - 'LANGUAGE': 'en_US:en', 10:05:03 INFO - 'LOGNAME': 'cltbld', 10:05:03 INFO - 'MAIL': '/var/mail/cltbld', 10:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:03 INFO - 'MOZ_NO_REMOTE': '1', 10:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:03 INFO - 'NO_EM_RESTART': '1', 10:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:03 INFO - 'PWD': '/builds/slave/test', 10:05:03 INFO - 'SHELL': '/bin/bash', 10:05:03 INFO - 'SHLVL': '1', 10:05:03 INFO - 'TERM': 'linux', 10:05:03 INFO - 'TMOUT': '86400', 10:05:03 INFO - 'USER': 'cltbld', 10:05:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:03 INFO - '_': '/tools/buildbot/bin/python'} 10:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:03 INFO - Cleaning up... 10:05:03 INFO - Return code: 0 10:05:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:03 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 10:05:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:05:03 INFO - Using env: {'DISPLAY': ':0', 10:05:03 INFO - 'HOME': '/home/cltbld', 10:05:03 INFO - 'LANG': 'en_US.UTF-8', 10:05:03 INFO - 'LANGUAGE': 'en_US:en', 10:05:03 INFO - 'LOGNAME': 'cltbld', 10:05:03 INFO - 'MAIL': '/var/mail/cltbld', 10:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:03 INFO - 'MOZ_NO_REMOTE': '1', 10:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:03 INFO - 'NO_EM_RESTART': '1', 10:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:03 INFO - 'PWD': '/builds/slave/test', 10:05:03 INFO - 'SHELL': '/bin/bash', 10:05:03 INFO - 'SHLVL': '1', 10:05:03 INFO - 'TERM': 'linux', 10:05:03 INFO - 'TMOUT': '86400', 10:05:03 INFO - 'USER': 'cltbld', 10:05:03 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:03 INFO - '_': '/tools/buildbot/bin/python'} 10:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:03 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 10:05:03 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 10:05:03 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 10:05:03 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 10:05:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:04 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 10:05:04 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 10:05:04 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 10:05:04 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 10:05:05 INFO - Downloading docopt-0.6.1.tar.gz 10:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:05 INFO - Running setup.py install for blobuploader 10:05:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:05 INFO - Running setup.py install for requests 10:05:05 INFO - Running setup.py install for docopt 10:05:05 INFO - Successfully installed blobuploader requests docopt 10:05:05 INFO - Cleaning up... 10:05:05 INFO - Return code: 0 10:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:05 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:05 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:05:05 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:05 INFO - Using env: {'DISPLAY': ':0', 10:05:05 INFO - 'HOME': '/home/cltbld', 10:05:05 INFO - 'LANG': 'en_US.UTF-8', 10:05:05 INFO - 'LANGUAGE': 'en_US:en', 10:05:05 INFO - 'LOGNAME': 'cltbld', 10:05:05 INFO - 'MAIL': '/var/mail/cltbld', 10:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:05 INFO - 'MOZ_NO_REMOTE': '1', 10:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:05 INFO - 'NO_EM_RESTART': '1', 10:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:05 INFO - 'PWD': '/builds/slave/test', 10:05:05 INFO - 'SHELL': '/bin/bash', 10:05:05 INFO - 'SHLVL': '1', 10:05:05 INFO - 'TERM': 'linux', 10:05:05 INFO - 'TMOUT': '86400', 10:05:05 INFO - 'USER': 'cltbld', 10:05:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:05 INFO - '_': '/tools/buildbot/bin/python'} 10:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:05 INFO - Running setup.py (path:/tmp/pip-tfDEgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:06 INFO - Running setup.py (path:/tmp/pip-bdmpvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:06 INFO - Running setup.py (path:/tmp/pip-3AUdrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:06 INFO - Running setup.py (path:/tmp/pip-D5Uk6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:06 INFO - Running setup.py (path:/tmp/pip-BghIFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:06 INFO - Running setup.py (path:/tmp/pip-io2G32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:06 INFO - Running setup.py (path:/tmp/pip-i3b9Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:06 INFO - Running setup.py (path:/tmp/pip-yV_hwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:06 INFO - Running setup.py (path:/tmp/pip-VDOGFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:06 INFO - Running setup.py (path:/tmp/pip-OkikSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:06 INFO - Running setup.py (path:/tmp/pip-cwgznY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:06 INFO - Running setup.py (path:/tmp/pip-U9zKJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:06 INFO - Running setup.py (path:/tmp/pip-AQS_GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:06 INFO - Running setup.py (path:/tmp/pip-cSiupO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:06 INFO - Running setup.py (path:/tmp/pip-b7wDJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:07 INFO - Running setup.py (path:/tmp/pip-kLBwhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:07 INFO - Running setup.py (path:/tmp/pip-e7eHnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:07 INFO - Running setup.py install for manifestparser 10:05:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozcrash 10:05:07 INFO - Running setup.py install for mozdebug 10:05:07 INFO - Running setup.py install for mozdevice 10:05:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozfile 10:05:07 INFO - Running setup.py install for mozhttpd 10:05:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozinfo 10:05:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozInstall 10:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:07 INFO - Running setup.py install for mozleak 10:05:08 INFO - Running setup.py install for mozlog 10:05:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Running setup.py install for moznetwork 10:05:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Running setup.py install for mozprocess 10:05:08 INFO - Running setup.py install for mozprofile 10:05:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Running setup.py install for mozrunner 10:05:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Running setup.py install for mozscreenshot 10:05:08 INFO - Running setup.py install for moztest 10:05:08 INFO - Running setup.py install for mozversion 10:05:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:08 INFO - Cleaning up... 10:05:08 INFO - Return code: 0 10:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:08 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:08 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:05:08 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:08 INFO - Using env: {'DISPLAY': ':0', 10:05:08 INFO - 'HOME': '/home/cltbld', 10:05:08 INFO - 'LANG': 'en_US.UTF-8', 10:05:08 INFO - 'LANGUAGE': 'en_US:en', 10:05:08 INFO - 'LOGNAME': 'cltbld', 10:05:08 INFO - 'MAIL': '/var/mail/cltbld', 10:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:08 INFO - 'MOZ_NO_REMOTE': '1', 10:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:08 INFO - 'NO_EM_RESTART': '1', 10:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:08 INFO - 'PWD': '/builds/slave/test', 10:05:08 INFO - 'SHELL': '/bin/bash', 10:05:08 INFO - 'SHLVL': '1', 10:05:08 INFO - 'TERM': 'linux', 10:05:08 INFO - 'TMOUT': '86400', 10:05:08 INFO - 'USER': 'cltbld', 10:05:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:08 INFO - '_': '/tools/buildbot/bin/python'} 10:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:09 INFO - Running setup.py (path:/tmp/pip-zOrE_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:09 INFO - Running setup.py (path:/tmp/pip-5keWOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:09 INFO - Running setup.py (path:/tmp/pip-ZGiqJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:09 INFO - Running setup.py (path:/tmp/pip-6gumDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:09 INFO - Running setup.py (path:/tmp/pip-3iAQMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:09 INFO - Running setup.py (path:/tmp/pip-XjNm5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:09 INFO - Running setup.py (path:/tmp/pip-vYDIzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:09 INFO - Running setup.py (path:/tmp/pip-RQPFZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:09 INFO - Running setup.py (path:/tmp/pip-TIuz74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:09 INFO - Running setup.py (path:/tmp/pip-3qC31X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:09 INFO - Running setup.py (path:/tmp/pip-d8yUWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:09 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)) 10:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:09 INFO - Running setup.py (path:/tmp/pip-Ksuqxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:10 INFO - Running setup.py (path:/tmp/pip-ftdQxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:10 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)) 10:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:10 INFO - Running setup.py (path:/tmp/pip-eNdi9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:10 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)) 10:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:10 INFO - Running setup.py (path:/tmp/pip-ZUp1w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:10 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)) 10:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:10 INFO - Running setup.py (path:/tmp/pip-Isdw3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:10 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)) 10:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:10 INFO - Running setup.py (path:/tmp/pip-7YgOxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:10 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)) 10:05:10 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)) 10:05:10 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)) 10:05:10 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)) 10:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:10 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 10:05:10 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 10:05:10 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 10:05:10 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 10:05:11 INFO - Downloading blessings-1.6.tar.gz 10:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:11 INFO - Installing collected packages: blessings 10:05:11 INFO - Running setup.py install for blessings 10:05:11 INFO - Successfully installed blessings 10:05:11 INFO - Cleaning up... 10:05:11 INFO - Return code: 0 10:05:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:11 INFO - Reading from file tmpfile_stdout 10:05:11 INFO - Current package versions: 10:05:11 INFO - argparse == 1.2.1 10:05:11 INFO - blessings == 1.6 10:05:11 INFO - blobuploader == 1.2.4 10:05:11 INFO - docopt == 0.6.1 10:05:11 INFO - functools32 == 3.2.3-2 10:05:11 INFO - jsonschema == 2.5.1 10:05:11 INFO - manifestparser == 1.1 10:05:11 INFO - mozInstall == 1.12 10:05:11 INFO - mozcrash == 1.0 10:05:11 INFO - mozdebug == 0.1 10:05:11 INFO - mozdevice == 0.50 10:05:11 INFO - mozfile == 1.2 10:05:11 INFO - mozhttpd == 0.7 10:05:11 INFO - mozinfo == 0.9 10:05:11 INFO - mozleak == 0.1 10:05:11 INFO - mozlog == 3.4 10:05:11 INFO - moznetwork == 0.27 10:05:11 INFO - mozprocess == 0.25 10:05:11 INFO - mozprofile == 0.28 10:05:11 INFO - mozrunner == 6.13 10:05:11 INFO - mozscreenshot == 0.1 10:05:11 INFO - mozsystemmonitor == 0.3 10:05:11 INFO - moztest == 0.8 10:05:11 INFO - mozversion == 1.4 10:05:11 INFO - psutil == 3.1.1 10:05:11 INFO - requests == 1.2.3 10:05:11 INFO - wsgiref == 0.1.2 10:05:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:11 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/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:11 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:05:11 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:05:11 INFO - Using env: {'DISPLAY': ':0', 10:05:11 INFO - 'HOME': '/home/cltbld', 10:05:11 INFO - 'LANG': 'en_US.UTF-8', 10:05:11 INFO - 'LANGUAGE': 'en_US:en', 10:05:11 INFO - 'LOGNAME': 'cltbld', 10:05:11 INFO - 'MAIL': '/var/mail/cltbld', 10:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:11 INFO - 'MOZ_NO_REMOTE': '1', 10:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:11 INFO - 'NO_EM_RESTART': '1', 10:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:11 INFO - 'PWD': '/builds/slave/test', 10:05:11 INFO - 'SHELL': '/bin/bash', 10:05:11 INFO - 'SHLVL': '1', 10:05:11 INFO - 'TERM': 'linux', 10:05:11 INFO - 'TMOUT': '86400', 10:05:11 INFO - 'USER': 'cltbld', 10:05:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:11 INFO - '_': '/tools/buildbot/bin/python'} 10:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 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)) 10:05:12 INFO - Cleaning up... 10:05:12 INFO - Return code: 0 10:05:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24b31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2680a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28265c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, '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': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', '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 10:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:05:12 INFO - Using env: {'DISPLAY': ':0', 10:05:12 INFO - 'HOME': '/home/cltbld', 10:05:12 INFO - 'LANG': 'en_US.UTF-8', 10:05:12 INFO - 'LANGUAGE': 'en_US:en', 10:05:12 INFO - 'LOGNAME': 'cltbld', 10:05:12 INFO - 'MAIL': '/var/mail/cltbld', 10:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:12 INFO - 'MOZ_NO_REMOTE': '1', 10:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:12 INFO - 'NO_EM_RESTART': '1', 10:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:12 INFO - 'PWD': '/builds/slave/test', 10:05:12 INFO - 'SHELL': '/bin/bash', 10:05:12 INFO - 'SHLVL': '1', 10:05:12 INFO - 'TERM': 'linux', 10:05:12 INFO - 'TMOUT': '86400', 10:05:12 INFO - 'USER': 'cltbld', 10:05:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:12 INFO - '_': '/tools/buildbot/bin/python'} 10:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:05:12 INFO - Cleaning up... 10:05:12 INFO - Return code: 0 10:05:12 INFO - Running post-action listener: _resource_record_post_action 10:05:12 INFO - Running post-action listener: _start_resource_monitoring 10:05:12 INFO - Starting resource monitoring. 10:05:12 INFO - [mozharness: 2017-05-21 17:05:12.489010Z] Finished create-virtualenv step (success) 10:05:12 INFO - [mozharness: 2017-05-21 17:05:12.489668Z] Running install step. 10:05:12 INFO - Running pre-action listener: _resource_record_pre_action 10:05:12 INFO - Running main action method: install 10:05:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:12 INFO - Reading from file tmpfile_stdout 10:05:12 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:12 INFO - Reading from file tmpfile_stdout 10:05:12 INFO - Output received: 10:05:12 INFO - Usage: mozinstall [options] installer 10:05:12 INFO - Options: 10:05:12 INFO - -h, --help show this help message and exit 10:05:12 INFO - -d DEST, --destination=DEST 10:05:12 INFO - Directory to install application into. [default: 10:05:12 INFO - "/builds/slave/test"] 10:05:12 INFO - --app=APP Application being installed. [default: firefox] 10:05:12 INFO - mkdir: /builds/slave/test/build/application 10:05:12 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'] 10:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:05:28 INFO - Reading from file tmpfile_stdout 10:05:28 INFO - Output received: 10:05:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:05:28 INFO - Running post-action listener: _resource_record_post_action 10:05:28 INFO - [mozharness: 2017-05-21 17:05:28.916888Z] Finished install step (success) 10:05:28 INFO - [mozharness: 2017-05-21 17:05:28.917164Z] Running run-tests step. 10:05:28 INFO - Running pre-action listener: _resource_record_pre_action 10:05:28 INFO - Running main action method: run_tests 10:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:05:28 INFO - Python 2.7.3 10:05:28 INFO - Return code: 0 10:05:28 INFO - grabbing minidump binary from tooltool 10:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 10:05:28 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 0x28237a0>, '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 0x28246a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2824b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:05:28 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 10:05:28 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 10:05:28 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 10:05:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:28 INFO - Return code: 0 10:05:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:05:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:05:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:05:28 INFO - ENV: RUST_BACKTRACE is now 1 10:05:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:05:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:05:29 INFO - Using env: {'DISPLAY': ':0', 10:05:29 INFO - 'HOME': '/home/cltbld', 10:05:29 INFO - 'LANG': 'en_US.UTF-8', 10:05:29 INFO - 'LANGUAGE': 'en_US:en', 10:05:29 INFO - 'LOGNAME': 'cltbld', 10:05:29 INFO - 'MAIL': '/var/mail/cltbld', 10:05:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:05:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:29 INFO - 'MOZ_NO_REMOTE': '1', 10:05:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:05:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:29 INFO - 'NO_EM_RESTART': '1', 10:05:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:29 INFO - 'PWD': '/builds/slave/test', 10:05:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:05:29 INFO - 'RUST_BACKTRACE': '1', 10:05:29 INFO - 'SHELL': '/bin/bash', 10:05:29 INFO - 'SHLVL': '1', 10:05:29 INFO - 'TERM': 'linux', 10:05:29 INFO - 'TMOUT': '86400', 10:05:29 INFO - 'USER': 'cltbld', 10:05:29 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610', 10:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:29 INFO - '_': '/tools/buildbot/bin/python'} 10:05:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:05:29 INFO - mozversion application_buildid: 20170521163721 10:05:29 INFO - mozversion application_changeset: b31a663614e8df7876563e03c4735aa5c8a38f5a 10:05:29 INFO - mozversion application_display_name: Nightly 10:05:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:29 INFO - mozversion application_name: Firefox 10:05:29 INFO - mozversion application_remotingname: firefox 10:05:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:05:29 INFO - mozversion application_vendor: Mozilla 10:05:29 INFO - mozversion application_version: 55.0a1 10:05:29 INFO - mozversion platform_buildid: 20170521163721 10:05:29 INFO - mozversion platform_changeset: b31a663614e8df7876563e03c4735aa5c8a38f5a 10:05:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:05:29 INFO - mozversion platform_version: 55.0a1 10:05:29 INFO - using testdate: 1495386329 10:05:29 INFO - actual date: 1495386329 10:05:29 INFO - starting webserver on 'localhost:38569' 10:05:29 INFO - SUITE-START | Running 2 tests 10:05:29 INFO - TEST-START | dromaeo_css 10:05:29 INFO - operating with platform_type : linux_ 10:05:29 INFO - Initialising browser for dromaeo_css test... 10:05:29 INFO - TEST-INFO | started process 30363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQqqLaV/profile http://localhost:38569/getInfo.html) 10:05:29 INFO - PID 30363 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2970: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:05:34 INFO - PID 30363 | __metrics Screen width/height:1600/1200 10:05:34 INFO - PID 30363 | colorDepth:24 10:05:34 INFO - PID 30363 | Browser inner width/height: 1024/695 10:05:34 INFO - PID 30363 | __metrics 10:05:36 INFO - TEST-INFO | 30363: exit 0 10:05:36 INFO - Browser initialized. 10:05:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:05:36 INFO - TEST-INFO | started process 30526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQqqLaV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:48 INFO - PID 30526 | RSS: Main: 168161280 10:05:48 INFO - PID 30526 | 10:08:53 INFO - PID 30526 | Cycle 1(1): loaded http://localhost:38569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38569/tests/dromaeo/cssquery-ext.html) 10:08:54 INFO - PID 30526 | RSS: Main: 170250240 10:08:54 INFO - PID 30526 | 10:11:56 INFO - PID 30526 | Cycle 1(1): loaded http://localhost:38569/tests/dromaeo/cssquery-ext.html (next: http://localhost:38569/tests/dromaeo/cssquery-jquery.html) 10:11:56 INFO - PID 30526 | RSS: Main: 171036672 10:11:56 INFO - PID 30526 | 10:14:58 INFO - PID 30526 | Cycle 1(1): loaded http://localhost:38569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38569/tests/dromaeo/cssquery-mootools.html) 10:14:59 INFO - PID 30526 | RSS: Main: 171204608 10:14:59 INFO - PID 30526 | 10:18:01 INFO - PID 30526 | Cycle 1(1): loaded http://localhost:38569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38569/tests/dromaeo/cssquery-prototype.html) 10:18:01 INFO - PID 30526 | RSS: Main: 168951808 10:18:01 INFO - PID 30526 | 10:21:04 INFO - PID 30526 | Cycle 1(1): loaded http://localhost:38569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38569/tests/dromaeo/cssquery-yui.html) 10:21:05 INFO - PID 30526 | RSS: Main: 169312256 10:21:05 INFO - PID 30526 | 10:24:06 INFO - PID 30526 | Cycle 1(1): loaded http://localhost:38569/tests/dromaeo/cssquery-yui.html (next: http://localhost:38569/tests/dromaeo/cssquery-dojo.html) 10:24:07 INFO - PID 30526 | RSS: Main: 168947712 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | __start_tp_report 10:24:07 INFO - PID 30526 | _x_x_mozilla_page_load 10:24:07 INFO - PID 30526 | _x_x_mozilla_page_load_details 10:24:07 INFO - PID 30526 | |i|pagename|runs| 10:24:07 INFO - PID 30526 | |0;dojo.html;2685.6760615409194;2690.798190135738;2708.079253053961;2725.3731641722416;2743.2593199836037;5104.157813960701;5233.780860967413;5241.42344342122;5265.078611243031;5295.020421222077;5207.479252074791;5234.92147617786;5295.682259064459;5317.308749862513;5329.866753331169;4653.162430762462;4669.486356500774;4686.414198225222;4752.857414277577;4786.138495070886;4704.200285951397;4722.126406614787;4798.328234047236;4804.303376010476;4854.514548545152;4541.409616749835;4732.43210814701;4762.023785124041;4784.808607655689;4796.3524924135145;4671.743054132022;4691.695039822434;4705.388299521074;4736.194846876005;4757.476677565465;4621.607163391116;4665.836695715668;4680.765961701902;4710.4347478302825;4757.476677565465;5251.975864706384;5266.4470230626;5285;5299.735013249322;5334.733263336818;5543.861403464905;5628.212050312959;5643.492085712305;5688.459596338341;5702.287214098238;5749.82750517481;5765;5769.394213607595;5772.826815195551;5795.710214489301;5287.682739035632;5343.62594618373;5343.732813359395;5348.304720386325;5349.518543331041;5677.261955945701;5800.88398232033;5847.502962248172;5905.782309538333;5931.940680593225;5560.666360018412;5569.248151499496;5574.052411090124;5599.468050535193;5610.214569960209;5479.178123281539;5513.641613295123;5637.830865074055;5673.06394444912;5685.260916080883;5553.333599968029;5686.658800471985;5688.089905615082;5707.914381284284;5715.371309155989;5507.449255074461;5592.804251851166;5608.551315894719;5614.887702245932;5618.2415373924;4592.908141837144;4611.792469338888;4614.077184563101;4672.43930728308;4678.789454474557;4017.9598204017584;4060.675145988314;4075.8369665213654;4084.9795751021056;4110.34234522481;4657.417822772153;4697.154512187839;4708.293755936637;4716.103940251342;4742.905141897143;5575.498205161473;5679.176519404663;5683.914741278884;5687.345955215121;5741.339745929272;4684.812607495662;4709.105269998689;4750.429948406213;4756.7859446325;4770.236762118045;4997.575206107449;5004.974975125101;5010.69935803853;5016.423111342169;5054;5227.503387178288;5245.108331583716;5260.263563101093;5268.209768534597;5269.683818970874;5568.805091821767;5653.660780353028;5674.602777805514;5760.942390576208;5770.105633626795;5297.390800058042;5305.973470132624;5310.734463276744;5317.1492561190025;5348.171033489815;5586.720663966867;5657.519110875622;5658.915116273177;5670.14938777956;5696.601237913306;5579.2746942897165;5620.8875822482505;5682.744276507649;5722.74247658848;5747.597668163356;5578.665280083208;5601.327840659147;5610.158476228598;5612.186232996274;5625.606207565595;5375.516203541543;5530.972345138249;5556.499915007668;5573.693446860461;5591.860203494945;5362.705051222064;5390.110631745718;5484.725763711878;5491.2312276282155;5495.422980587141;5461.863453413696;5555.749991250323;5599.300087489064;5604.467575580314;5612.045952188057;5279.340082489689;5374.596905232045;5398.352197736297;5414.187871819258;5438.129899216106 10:24:07 INFO - PID 30526 | |1;ext.html;670.0886793960216;713.5326361233392;725.231254869838;1148.8908553687402;1179.5517703272756;35485.2902941941;36432.817835910784;36614.8169259154;36636.63363366365;36662.816685916565;34786.47820282691;34835;34853.477197842054;34940.301193976105;35184.47223291652;6651.800445986628;6789.422899053587;6845.110135682379;7094.68073936674;7139;7022.82442938928;7071.575705457663;7115.430765538745;7127.857442851166;7140.714371425137;7089.680964356617;7141.714331426762;7147.178074521418;7164.749233776819;7168.462365322595;7084.220735719066;7097.325754053382;7114.110736157981;7139.286071392871;7154.356107950257;7047.577145371294;7067.8586428271665;7111.53775004623;7111.644417779142;7142.607156606385;33575.49636755451;33598.83200584006;33748.32503349919;33868.661313386794;33893.83053084744;2799.622051023106;2801.523740964021;2821.2523681224493;2832.730890565393;2848.2309776360266;22384.55230895389;22439;22473.550528989494;22566.323010309552;22584.096636134534;2958.4970555005702;2960.319126600872;2988.208124846917;2989.282572182682;2989.387175628991;143513.2824335882;143688.28155859155;143934;151162;156659;41028;41252.587474125474;41585.79207104006;41620.79189604093;41621;42621.36067958983;42676;42752.57247427548;47778.761106194244;47838;13455.32723363828;13637.590872273848;13644;13668.794968075486;13689.178649281075;10781.622643207607;10812.243142980073;10855.891441085647;10869.184811139037;10872.130229581615;13313.334333283297;13315.201087934562;13368.064235503422;13467.86532134666;13523;5474.890502189934;5542.91685624716;5577.191307260506;5611.663300202001;5628.943710562842;831.4637059096849;867.6225841758855;890.7594949363636;905.9320550958572;908.8318661047728;19579.216831326874;20560.58878822415;20734.06696698652;20766.688499672517;20766.896165519076;951.6383774165772;968.9757756056155;985.5909797433984;994.3238597753452;995.2983146881576;10572.682819515427;10811.83782243267;10851.294665846695;10855.968682975104;10947.726306842393;189381;190339;190808;191101;191911;43029;43250;43334;43425.565744342784;43447.78276108662;1181.1023622047264;1226.6994586326407;1226.920250183735;1232.6979889927024;1248.7003119251315;19179.136938837506;19410.126544305822;19419.8058019418;20165.193392264733;20434.182632694527;30868.691313086583;39490.802545987084;40142.18649228319;40191;40471.59528404678;169932;171050;171893;172373;172852;31239.68760312368;31390.843045784626;31434.685653143177;31442;31746.365072697954;37066.25867482581;37693.434598481595;38297.425538616386;38300.6169938297;38332.80833595814;28994.42011159723;29004.854975724986;29346.70653293525;29680.851595742748;29876.253093672833;28443.28891777722;28557.571636425884;28842.42315153727;29849;29871.551926720684;31840.68159318377;31960;32058.6794132065;32203.677963220067;32274.515882262254;27003.1899043029;27480.312992174557;28124.156275311772;28314.2921426966;28745.28136796513;20358.79641203569;22924.19765308206;23117.65323520115;23185.188518401774;23375 10:24:07 INFO - PID 30526 | |2;jquery.html;406.0903575989782;410.6427408154906;417.13444602449914;426.92528807458706;427.9229738647043;17151;17776.733348999776;17808.643827123466;17987.820121798777;18674.906625466887;18912.1489532971;18912.338068167617;19077.332293369735;19099.71350429741;19151.23395064196;5290.55030322423;5309.761060752266;5455.672659640434;5476.972615136939;5480.671159730409;5346.812861549846;5382.111951527993;5427.782888684448;5435.912817436529;5443.618946673734;5225.634205605609;5305.734713264322;5330.38700549436;5336.9733151334185;5386;5321.760520776575;5370.382406023279;5376.38171610264;5377.7311134443125;5388.515033646951;4696.8590942271785;4845.63657725672;4847.394075740533;4859.611231101503;4880.877978050577;21231.36305910825;21250.14999400022;21486.892565537073;21500.139994400204;21538.89230553837;1619.6679680665436;1661.460025491708;1663.3429795230936;1663.3928616055173;1670.1649175412294;13089.934550327283;13534.187948723009;13678.521251756141;13696.589102326947;13822.239776812272;1814.6461440019202;1815.9631428215664;1847.6397102565006;1862.4040307101732;1880.4640677406874;78650;80758.19241807566;81304.59347703223;81493.59253203755;81543.9999999994;10223.233257505568;10670.51982660782;10703.411312377893;10770.299930504492;10818.891811081945;14225.430982760781;14340.498082567061;14347.497837575635;14349.78475322871;14490.637734056521;7406.518576292524;7603.619819009027;7664.118626357928;7889.250521200477;7902.960485197537;7194.244604316576;7290.9635451822405;7305.634718264066;7495.250474952571;7506.812329691692;6861;6891.3797758202;6981.127359080115;7003.124609423822;7024.4029257513685;1898.4874083997242;1914.3012800328058;1944.8735832170864;1967.5538479217764;1974.5557249619008;854.107457706698;894.9731508054768;897.4032268541347;901.193431878465;924.8751418558409;16911.661766764842;17076.743848842278;17594.824051759573;17798.822011779717;17922.19350129221;889.7731078575051;901.1709227510706;901.8376692195336;909.4316052467208;911.3028533172129;9166.427105740599;9369.953150234205;9739.123478886933;9773;9862.309638325249;352676;358776;358908;360188;369212;72975.88200119635;73517.63241183759;73884.63057684677;75876.62061689766;77298.61350693322;1056.6513050693252;1069.7593041565585;1089.5805115030612;1094.7974624694457;1096.6929259807266;16974;18142.274309027493;18447.815521844608;18453.630927381644;18628.534286642942;37808.243835122594;38058.61941380661;38272.61727382802;38560.80719596384;38838;47027.52972470369;47627.76186119047;48251.27623085727;48933.51066489289;49058;8133;8253.298469630148;8266.090730019572;8352.582370881553;8494.53280069602;12734.363281836057;12735.426905789076;13075.803862941873;13090.869091308965;13338.399772010089;11304.660860174208;11305.886941130484;11426;11579.88420115788;11620.418979050844;10103.24225683062;10362.326448780805;10493.47532623381;10537.789244215226;10559.89121142269;11059.612913547988;11081.667549973514;11195.832062519232;11237.157213209206;11542.884571154182;8086.5148091114725;8126.187381261827;8256.25693687547;8432.662693492437;8500.659973600987;11187.664370068911;11215.66353009411;11336.716582085513;11520.769584608428;11577.421128943688 10:24:07 INFO - PID 30526 | |3;mootools.html;1233.297020698202;1247.8939290160336;1285.3316275536715;1286.2989670629506;1299.7595444842705;9485.715428537147;9832.705018849438;9845.852312215322;10063.748406289846;10357;10209.693709188718;10337.638182663608;10339.948300258508;10367.170626349875;10368.377897326165;2046.4167712202025;2081.708560801489;2093.3196711068886;2093.58128374325;2114.577084583082;2091.943568497914;2141.550274442369;2142.3787101740554;2155.665871789875;2176.923807666732;2167.2847960173103;2175.5213852952324;2204.360735386736;2214.3135627955303;2245.6743772153027;2101.107029512451;2102.8317734581196;2123.543438160803;2130.936071917845;2148.6239908016037;1977.0905383523452;2041.4181958142008;2094.6124966881175;2110.9577808443746;2133.4986278224605;9507.57215925285;9581;9593.664221752206;9602.327837051409;9609.855852162224;5333.306670132897;5497.147942068946;5508.91736623951;5541.501264886179;5542.473465020857;3032.7270545651;3122.5160100184507;3178.7933784303946;3225.3549290142064;3225.758068144875;1015.1878497202282;1024.8257796174669;1042.5152304178519;1070.1278458056659;1072.3673032910542;14146.858531414657;14214.85785142156;14246;14323.856761432357;14329.283535823271;4472.932906006413;4603.516630753789;4754.358161648202;4788.209945358977;4819.807207711652;10012.499375031219;10015.298929074896;10042.849357259647;10063.798724025479;10074.949625251973;5382.730863456812;5390.676559406448;5411.83764487066;5431.429699881534;5443;4825.4933232010835;5047.470015648378;5057.873553161126;5133.050385678662;5143.639945203875;3684.834182461742;3761.3417651910804;3781.8865434037025;3844.2119365529998;3856.46009558662;1025.9743506412399;1032.7779527401494;1033.426448321174;1038.8935783390664;1042.8696412948382;665.238302144052;684.8835697931364;695.0755495191383;705.28413660135;712.0565251042286;4957.652964292465;4975.378077740283;5010.724410157476;5176.301199338041;5470.9452905471235;505.10092036175666;516.3107251818789;517.350724840323;518.7872972081428;519.6310619460226;3039.6960303969868;3063;3272.9181770455452;3418.2821607462215;3419.4528875380315;12379.62861114168;12883.420246088948;12895.161814482217;12913.160644558073;12916.483340666457;12497;12634.368281585885;12676.112672113048;12682.302473364054;12854;6752.696128674222;6856.90289553669;6857.245702972669;6922.134733158356;7035.190953040364;5289.444608316071;5296.973515132399;5306.336707911511;5752.482276595127;5953.493953014043;11198.21612487118;11463.484143213409;11468.369239691898;11472.483738231633;11701.590444334408;11575.363355015219;11732.765344693229;11764.764704705687;11882.227655202385;11892.524299028288;7968.7609371718945;8037.557934313435;8040.758777236459;8133;8196.713115041184;9009.684661036832;9154.542272886461;9207.447553146832;9218;9227.431336672917;7908.802279943047;7921.881171782313;8044.839103217786;8081;8091.83816323682;7645.1972542882195;7773.4169937256065;7786.922130778847;7820.061592608923;7972.561509116822;6834.179898412222;7037.859242815218;7047.295270473117;7048.471364647569;7049.541779784297;4878.780454879468;4889.242167464049;4911.533404326583;4940.283658869372;4999.350084488993;4906.533879281463;4984.32711583946;5034.773435195351;5042.974785126051;5137.92293115611 10:24:07 INFO - PID 30526 | |4;prototype.html;369.2117329501514;383.7141329709367;389.978551179685;395.05581659832995;397.0391652201673;5491.917621235674;5641.420402287361;5650.406707295737;5663.207150998858;5682.4601662842015;5390.8921821563545;5470.839018587655;5482.205080263359;5505.862353441166;5512.255845460862;4163.271427500198;4163.583641635827;4164.354525048622;4185.476815398075;4197.118605092935;4121.958780412202;4170.249355116093;4174.31123864562;4202.201581699483;4206.284931561627;4119.814608342632;4120.093579412524;4122.083231297446;4124.566920473352;4161.167766446722;4103.2409004333995;4111.650509706664;4126.133511962492;4139.254934111858;4168.374743788456;3545.3441113393847;3606.7114630829733;3608;3614.313280476701;3616;5329.520343169094;5359.919601205985;5394.7842086316505;5415.214793854869;5424.403315635277;4814.15752243356;4817.325574419584;4830.299606557065;4840.636952228561;4842.757862106916;5665.66006039639;5749.252597162342;5821.7380217890295;5843.328017278025;5844.386339434341;3986.46859244379;3989.940150897739;3992.201559688045;3997.2205419943125;4012.8394864205397;5939.168516407706;6113.908291375633;6154.5384096192965;6167.907481387782;6175.691215439255;4064.309067458539;4064.7967601619803;4087.693422993228;4101.507819061731;4106;4160.729552579072;4172;4178.22702799983;4178.937315940263;4182.2890108681595;4708.4349878014855;4807.423109226916;4839.28205487054;4846.151923413388;4850.927236091461;5782.710864456844;5791.681457519792;5799;5813.273340832396;5887.4406931341455;1417.971640567183;1430.4850253908585;1436.174199835099;1436.913785172893;1443.408202636935;930.3394589841154;957.5260246178186;961.1061712607342;963.691618682029;967.7870868408938;4844.75776211188;4876.8780780480065;4885.828995985124;4900.166971614834;4902.779374928136;5961.2846458425265;6005.489533389624;6008.218931538872;6020.488258498077;6044.335123136451;4708.646851486153;4833.685810422311;4837.830675926396;4868.269759536027;4886.729450342866;3130.1235654016914;3147.1502694272876;3147.1660010097344;3172.8419127018933;3176.936461270762;5423.647462914898;5531.695756733418;5536.141898005735;5541.0580201365865;5552.500824777288;6073.878522429527;6087.57386982907;6113.23584551931;6148.1392605035335;6148.78479253224;5510.6969116698965;5524.475174858382;5557.194206839986;5572.944270557324;5602.459323685856;5804.65172089676;6013.488853447506;6021.2473440819895;6026.7589296429405;6080.847978800389;5934.9406505934385;5957.553183511341;5966.164736936919;5983.9401605983385;6002.939970600412;5427.918581221364;5592.273004509388;5604.656391296778;5608.775648973995;5619.578531610064;4064.800883739363;4075.0423650442717;4095.488063992001;4113.321301985139;4117.135401565704;5895.29256489224;6079.422454866957;6092.329843717276;6130.816075517741;6139.447449729546;5878.617889837147;5892.1161825726485;5903.616264942765;5907.379725128972;5922.466977972003;5871.295444546511;5890.617109887844;5898.587098903035;5902.940970590411;5910.7931222407005;5738.1679656450415;5745.540356771365;5802.593818432669;5828.60113572748;5839.795607153899;5905.527557795452;5913.438223368773;5930.436608522184;5938.594869078031;5939.287285525765;5581.665100094007;5726.420986883198;5737.225474560881;5748.252727145445;5771.59598828078 10:24:07 INFO - PID 30526 | |5;yui.html;689.6138162628928;700.6111608057525;700.8177873752823;701.5404909784091;710.3145464626638;12683.746325073493;13098.869011309873;13102.803457948126;13591.320433978286;13936.581902542915;14274.857251427482;14323.427062917497;14374.784378234308;14392.64018399538;14426.495072672458;911.9133682300171;920.8802855628759;926.8934072581671;929.8140371925608;931.8741969834088;920.0569416348263;923.487464457226;924.191332583989;925.6575067225136;930.4277869110482;952.5808644196566;958.0706714486937;958.8226178157063;959.472290240365;963.9518024098802;954.8806399200065;957.621739412935;958.5542722633974;960.1358777100666;970.6311601591385;635.7425242776683;670.269406347084;678.2098854834112;709.7551344786092;716.4125417157933;14099.50651727195;14245.501407450689;14260.286985650677;14298;14325.856741432557;13244.404001819941;13841.930790346085;13990.370433330525;14022.509212177525;14078.08492447998;10185.490725463771;10460.63387781424;10590.046895779416;10756.085732712729;10764.677059688222;2853.1583182961076;2854.8287102773693;2870.7129287071334;2872.8994485193125;2878.29481776966;68794;69630.65184674095;70312.94530582096;71013.64493177501;72190.63904680443;10834;11279.830802537968;11306.830397544043;11462.770744585228;11560;20452.897735511226;20567.691484627743;20728.378148655564;20978.580428391346;21037.68443473349;5726.79956201531;5879.647221166743;5910.8817823643285;5914.0537513998415;5936.020556608198;2741.684706258766;2765.184270640166;2790.037437084203;2792.2181789099086;2793.6228609137506;3423.845926933294;3427.725781937439;3452.1369657585606;3509.052555809968;3511.754177207571;691.0463560286772;693.7918624412656;698.8287869472011;700.9018737376771;704.4188544450747;529.1190168369699;544.77119609764;552.1689856765543;552.4806681719172;555.5860883641712;8942.284617230736;9244.491552964517;9492.620295188253;9668.70993870185;9692.273079519064;495.93552838131535;500.32706010415933;504.06747517093083;516.1406258579498;524.0043916558493;4002.459667944848;4139.068709540329;4149.315362965137;4158.6465150461945;4263.936040959388;58372.70813645905;59402;59529.70235148796;61005.38994609997;62104.37895620986;56294.437055629736;56318.71840640771;56375.15437268444;56632;57148;50184.749076253654;51218.74390628023;51476.22785658218;51546.22680659718;52134;8451.535165565952;8455.323574113932;8496.065432802263;8559.272461840814;8661.177188167114;24367;24438.51122977566;24656.1370352044;25888.741112588632;26341.473170536865;41396.37905431481;41627.95930101772;42824;43216;43511;12395.318257495564;12575.622731318075;12761;12858.807117893051;12867.678308042374;13934.790978135134;13947.442102315794;14128.717425651224;14254.928725356722;14547.636309092357;12661.746765064463;12819.487220511075;12983.740325193632;13121.803172952223;13199.20804751718;12319.63041108768;12349.629511114681;12473.625791226277;12485.687857803627;12592.811107833573;12927.030472714396;12947.093703440669;13016;13036.348182590642;13077.149985250928;9457.29070319715;10092.394456332644;10128.848067279145;10204;10557.947210264207;10399.844002340122;10688.679339619825;10902.618408355669;10924.352992782371;10980.121590272918 10:24:07 INFO - PID 30526 | __end_tp_report 10:24:07 INFO - PID 30526 | __start_cc_report 10:24:07 INFO - PID 30526 | _x_x_mozilla_cycle_collect,300 10:24:07 INFO - PID 30526 | __end_cc_report 10:24:07 INFO - PID 30526 | __startTimestamp1495387447123__endTimestamp 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | ------- Summary: start ------- 10:24:07 INFO - PID 30526 | Number of tests: 6 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | [#0] dojo.html Cycles:165 Average:5183.87 Median:5343.73 stddev:618.44 (11.6%) stddev-sans-first:588.47 10:24:07 INFO - PID 30526 | Values: 2685.7 2690.8 2708.1 2725.4 2743.3 5104.2 5233.8 5241.4 5265.1 5295.0 5207.5 5234.9 5295.7 5317.3 5329.9 4653.2 4669.5 4686.4 4752.9 4786.1 4704.2 4722.1 4798.3 4804.3 4854.5 4541.4 4732.4 4762.0 4784.8 4796.4 4671.7 4691.7 4705.4 4736.2 4757.5 4621.6 4665.8 4680.8 4710.4 4757.5 5252.0 5266.4 5285.0 5299.7 5334.7 5543.9 5628.2 5643.5 5688.5 5702.3 5749.8 5765.0 5769.4 5772.8 5795.7 5287.7 5343.6 5343.7 5348.3 5349.5 5677.3 5800.9 5847.5 5905.8 5931.9 5560.7 5569.2 5574.1 5599.5 5610.2 5479.2 5513.6 5637.8 5673.1 5685.3 5553.3 5686.7 5688.1 5707.9 5715.4 5507.4 5592.8 5608.6 5614.9 5618.2 4592.9 4611.8 4614.1 4672.4 4678.8 4018.0 4060.7 4075.8 4085.0 4110.3 4657.4 4697.2 4708.3 4716.1 4742.9 5575.5 5679.2 5683.9 5687.3 5741.3 4684.8 4709.1 4750.4 4756.8 4770.2 4997.6 5005.0 5010.7 5016.4 5054.0 5227.5 5245.1 5260.3 5268.2 5269.7 5568.8 5653.7 5674.6 5760.9 5770.1 5297.4 5306.0 5310.7 5317.1 5348.2 5586.7 5657.5 5658.9 5670.1 5696.6 5579.3 5620.9 5682.7 5722.7 5747.6 5578.7 5601.3 5610.2 5612.2 5625.6 5375.5 5531.0 5556.5 5573.7 5591.9 5362.7 5390.1 5484.7 5491.2 5495.4 5461.9 5555.7 5599.3 5604.5 5612.0 5279.3 5374.6 5398.4 5414.2 5438.1 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | [#1] ext.html Cycles:180 Average:32093.06 Median:31438.34 stddev:44233.55 (140.7%) stddev-sans-first:44294.70 10:24:07 INFO - PID 30526 | Values: 670.1 713.5 725.2 1148.9 1179.6 35485.3 36432.8 36614.8 36636.6 36662.8 34786.5 34835.0 34853.5 34940.3 35184.5 6651.8 6789.4 6845.1 7094.7 7139.0 7022.8 7071.6 7115.4 7127.9 7140.7 7089.7 7141.7 7147.2 7164.7 7168.5 7084.2 7097.3 7114.1 7139.3 7154.4 7047.6 7067.9 7111.5 7111.6 7142.6 33575.5 33598.8 33748.3 33868.7 33893.8 2799.6 2801.5 2821.3 2832.7 2848.2 22384.6 22439.0 22473.6 22566.3 22584.1 2958.5 2960.3 2988.2 2989.3 2989.4 143513.3 143688.3 143934.0 151162.0 156659.0 41028.0 41252.6 41585.8 41620.8 41621.0 42621.4 42676.0 42752.6 47778.8 47838.0 13455.3 13637.6 13644.0 13668.8 13689.2 10781.6 10812.2 10855.9 10869.2 10872.1 13313.3 13315.2 13368.1 13467.9 13523.0 5474.9 5542.9 5577.2 5611.7 5628.9 831.5 867.6 890.8 905.9 908.8 19579.2 20560.6 20734.1 20766.7 20766.9 951.6 969.0 985.6 994.3 995.3 10572.7 10811.8 10851.3 10856.0 10947.7 189381.0 190339.0 190808.0 191101.0 191911.0 43029.0 43250.0 43334.0 43425.6 43447.8 1181.1 1226.7 1226.9 1232.7 1248.7 19179.1 19410.1 19419.8 20165.2 20434.2 30868.7 39490.8 40142.2 40191.0 40471.6 169932.0 171050.0 171893.0 172373.0 172852.0 31239.7 31390.8 31434.7 31442.0 31746.4 37066.3 37693.4 38297.4 38300.6 38332.8 28994.4 29004.9 29346.7 29680.9 29876.3 28443.3 28557.6 28842.4 29849.0 29871.6 31840.7 31960.0 32058.7 32203.7 32274.5 27003.2 27480.3 28124.2 28314.3 28745.3 20358.8 22924.2 23117.7 23185.2 23375.0 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | [#2] jquery.html Cycles:180 Average:24306.16 Median:37933.43 stddev:59725.78 (157.4%) stddev-sans-first:59866.37 10:24:07 INFO - PID 30526 | Values: 406.1 410.6 417.1 426.9 427.9 17151.0 17776.7 17808.6 17987.8 18674.9 18912.1 18912.3 19077.3 19099.7 19151.2 5290.6 5309.8 5455.7 5477.0 5480.7 5346.8 5382.1 5427.8 5435.9 5443.6 5225.6 5305.7 5330.4 5337.0 5386.0 5321.8 5370.4 5376.4 5377.7 5388.5 4696.9 4845.6 4847.4 4859.6 4880.9 21231.4 21250.1 21486.9 21500.1 21538.9 1619.7 1661.5 1663.3 1663.4 1670.2 13089.9 13534.2 13678.5 13696.6 13822.2 1814.6 1816.0 1847.6 1862.4 1880.5 78650.0 80758.2 81304.6 81493.6 81544.0 10223.2 10670.5 10703.4 10770.3 10818.9 14225.4 14340.5 14347.5 14349.8 14490.6 7406.5 7603.6 7664.1 7889.3 7903.0 7194.2 7291.0 7305.6 7495.3 7506.8 6861.0 6891.4 6981.1 7003.1 7024.4 1898.5 1914.3 1944.9 1967.6 1974.6 854.1 895.0 897.4 901.2 924.9 16911.7 17076.7 17594.8 17798.8 17922.2 889.8 901.2 901.8 909.4 911.3 9166.4 9370.0 9739.1 9773.0 9862.3 352676.0 358776.0 358908.0 360188.0 369212.0 72975.9 73517.6 73884.6 75876.6 77298.6 1056.7 1069.8 1089.6 1094.8 1096.7 16974.0 18142.3 18447.8 18453.6 18628.5 37808.2 38058.6 38272.6 38560.8 38838.0 47027.5 47627.8 48251.3 48933.5 49058.0 8133.0 8253.3 8266.1 8352.6 8494.5 12734.4 12735.4 13075.8 13090.9 13338.4 11304.7 11305.9 11426.0 11579.9 11620.4 10103.2 10362.3 10493.5 10537.8 10559.9 11059.6 11081.7 11195.8 11237.2 11542.9 8086.5 8126.2 8256.3 8432.7 8500.7 11187.7 11215.7 11336.7 11520.8 11577.4 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | [#3] mootools.html Cycles:180 Average:6008.95 Median:3850.34 stddev:3886.63 (100.9%) stddev-sans-first:3880.97 10:24:07 INFO - PID 30526 | Values: 1233.3 1247.9 1285.3 1286.3 1299.8 9485.7 9832.7 9845.9 10063.7 10357.0 10209.7 10337.6 10339.9 10367.2 10368.4 2046.4 2081.7 2093.3 2093.6 2114.6 2091.9 2141.6 2142.4 2155.7 2176.9 2167.3 2175.5 2204.4 2214.3 2245.7 2101.1 2102.8 2123.5 2130.9 2148.6 1977.1 2041.4 2094.6 2111.0 2133.5 9507.6 9581.0 9593.7 9602.3 9609.9 5333.3 5497.1 5508.9 5541.5 5542.5 3032.7 3122.5 3178.8 3225.4 3225.8 1015.2 1024.8 1042.5 1070.1 1072.4 14146.9 14214.9 14246.0 14323.9 14329.3 4472.9 4603.5 4754.4 4788.2 4819.8 10012.5 10015.3 10042.8 10063.8 10074.9 5382.7 5390.7 5411.8 5431.4 5443.0 4825.5 5047.5 5057.9 5133.1 5143.6 3684.8 3761.3 3781.9 3844.2 3856.5 1026.0 1032.8 1033.4 1038.9 1042.9 665.2 684.9 695.1 705.3 712.1 4957.7 4975.4 5010.7 5176.3 5470.9 505.1 516.3 517.4 518.8 519.6 3039.7 3063.0 3272.9 3418.3 3419.5 12379.6 12883.4 12895.2 12913.2 12916.5 12497.0 12634.4 12676.1 12682.3 12854.0 6752.7 6856.9 6857.2 6922.1 7035.2 5289.4 5297.0 5306.3 5752.5 5953.5 11198.2 11463.5 11468.4 11472.5 11701.6 11575.4 11732.8 11764.8 11882.2 11892.5 7968.8 8037.6 8040.8 8133.0 8196.7 9009.7 9154.5 9207.4 9218.0 9227.4 7908.8 7921.9 8044.8 8081.0 8091.8 7645.2 7773.4 7786.9 7820.1 7972.6 6834.2 7037.9 7047.3 7048.5 7049.5 4878.8 4889.2 4911.5 4940.3 4999.4 4906.5 4984.3 5034.8 5043.0 5137.9 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | [#4] prototype.html Cycles:180 Average:4778.96 Median:5498.89 stddev:1432.50 (26.1%) stddev-sans-first:1397.76 10:24:07 INFO - PID 30526 | Values: 369.2 383.7 390.0 395.1 397.0 5491.9 5641.4 5650.4 5663.2 5682.5 5390.9 5470.8 5482.2 5505.9 5512.3 4163.3 4163.6 4164.4 4185.5 4197.1 4122.0 4170.2 4174.3 4202.2 4206.3 4119.8 4120.1 4122.1 4124.6 4161.2 4103.2 4111.7 4126.1 4139.3 4168.4 3545.3 3606.7 3608.0 3614.3 3616.0 5329.5 5359.9 5394.8 5415.2 5424.4 4814.2 4817.3 4830.3 4840.6 4842.8 5665.7 5749.3 5821.7 5843.3 5844.4 3986.5 3989.9 3992.2 3997.2 4012.8 5939.2 6113.9 6154.5 6167.9 6175.7 4064.3 4064.8 4087.7 4101.5 4106.0 4160.7 4172.0 4178.2 4178.9 4182.3 4708.4 4807.4 4839.3 4846.2 4850.9 5782.7 5791.7 5799.0 5813.3 5887.4 1418.0 1430.5 1436.2 1436.9 1443.4 930.3 957.5 961.1 963.7 967.8 4844.8 4876.9 4885.8 4900.2 4902.8 5961.3 6005.5 6008.2 6020.5 6044.3 4708.6 4833.7 4837.8 4868.3 4886.7 3130.1 3147.2 3147.2 3172.8 3176.9 5423.6 5531.7 5536.1 5541.1 5552.5 6073.9 6087.6 6113.2 6148.1 6148.8 5510.7 5524.5 5557.2 5572.9 5602.5 5804.7 6013.5 6021.2 6026.8 6080.8 5934.9 5957.6 5966.2 5983.9 6002.9 5427.9 5592.3 5604.7 5608.8 5619.6 4064.8 4075.0 4095.5 4113.3 4117.1 5895.3 6079.4 6092.3 6130.8 6139.4 5878.6 5892.1 5903.6 5907.4 5922.5 5871.3 5890.6 5898.6 5902.9 5910.8 5738.2 5745.5 5802.6 5828.6 5839.8 5905.5 5913.4 5930.4 5938.6 5939.3 5581.7 5726.4 5737.2 5748.3 5771.6 10:24:07 INFO - PID 30526 | 10:24:07 INFO - PID 30526 | [#5] yui.html Cycles:180 Average:14844.15 Median:22767.72 stddev:18056.85 (79.3%) stddev-sans-first:18076.22 10:24:07 INFO - PID 30526 | Values: 689.6 700.6 700.8 701.5 710.3 12683.7 13098.9 13102.8 13591.3 13936.6 14274.9 14323.4 14374.8 14392.6 14426.5 911.9 920.9 926.9 929.8 931.9 920.1 923.5 924.2 925.7 930.4 952.6 958.1 958.8 959.5 964.0 954.9 957.6 958.6 960.1 970.6 635.7 670.3 678.2 709.8 716.4 14099.5 14245.5 14260.3 14298.0 14325.9 13244.4 13841.9 13990.4 14022.5 14078.1 10185.5 10460.6 10590.0 10756.1 10764.7 2853.2 2854.8 2870.7 2872.9 2878.3 68794.0 69630.7 70312.9 71013.6 72190.6 10834.0 11279.8 11306.8 11462.8 11560.0 20452.9 20567.7 20728.4 20978.6 21037.7 5726.8 5879.6 5910.9 5914.1 5936.0 2741.7 2765.2 2790.0 2792.2 2793.6 3423.8 3427.7 3452.1 3509.1 3511.8 691.0 693.8 698.8 700.9 704.4 529.1 544.8 552.2 552.5 555.6 8942.3 9244.5 9492.6 9668.7 9692.3 495.9 500.3 504.1 516.1 524.0 4002.5 4139.1 4149.3 4158.6 4263.9 58372.7 59402.0 59529.7 61005.4 62104.4 56294.4 56318.7 56375.2 56632.0 57148.0 50184.7 51218.7 51476.2 51546.2 52134.0 8451.5 8455.3 8496.1 8559.3 8661.2 24367.0 24438.5 24656.1 25888.7 26341.5 41396.4 41628.0 42824.0 43216.0 43511.0 12395.3 12575.6 12761.0 12858.8 12867.7 13934.8 13947.4 14128.7 14254.9 14547.6 12661.7 12819.5 12983.7 13121.8 13199.2 12319.6 12349.6 12473.6 12485.7 12592.8 12927.0 12947.1 13016.0 13036.3 13077.1 9457.3 10092.4 10128.8 10204.0 10557.9 10399.8 10688.7 10902.6 10924.4 10980.1 10:24:07 INFO - PID 30526 | -------- Summary: end -------- 10:24:07 INFO - PID 30526 | 10:24:08 INFO - TEST-INFO | 30526: exit 0 10:24:08 INFO - TEST-OK | dromaeo_css | took 1118926ms 10:24:08 INFO - TEST-START | kraken 10:24:08 INFO - operating with platform_type : linux_ 10:24:08 INFO - Initialising browser for kraken test... 10:24:08 INFO - TEST-INFO | started process 30934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL3d93W/profile http://localhost:38569/getInfo.html) 10:24:08 INFO - PID 30934 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2970: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:24:12 INFO - PID 30934 | __metrics Screen width/height:1600/1200 10:24:12 INFO - PID 30934 | colorDepth:24 10:24:12 INFO - PID 30934 | Browser inner width/height: 1024/695 10:24:12 INFO - PID 30934 | __metrics 10:24:15 INFO - TEST-INFO | 30934: exit 0 10:24:15 INFO - Browser initialized. 10:24:15 INFO - Running cycle 1/1 for kraken test... 10:24:15 INFO - TEST-INFO | started process 31099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL3d93W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:24:26 INFO - PID 31099 | RSS: Main: 166580224 10:24:26 INFO - PID 31099 | 10:24:29 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38569/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:30 INFO - PID 31099 | RSS: Main: 170115072 10:24:30 INFO - PID 31099 | 10:24:33 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38569/tests/kraken/driver.html?testName=audio-dft) 10:24:33 INFO - PID 31099 | RSS: Main: 169295872 10:24:33 INFO - PID 31099 | 10:24:36 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38569/tests/kraken/driver.html?testName=audio-fft) 10:24:37 INFO - PID 31099 | RSS: Main: 165134336 10:24:37 INFO - PID 31099 | 10:24:39 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38569/tests/kraken/driver.html?testName=audio-oscillator) 10:24:39 INFO - PID 31099 | RSS: Main: 166363136 10:24:39 INFO - PID 31099 | 10:24:41 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:42 INFO - PID 31099 | RSS: Main: 166309888 10:24:42 INFO - PID 31099 | 10:24:45 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38569/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:46 INFO - PID 31099 | RSS: Main: 171356160 10:24:46 INFO - PID 31099 | 10:24:49 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38569/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:50 INFO - PID 31099 | RSS: Main: 168476672 10:24:50 INFO - PID 31099 | 10:24:53 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38569/tests/kraken/driver.html?testName=json-parse-financial) 10:24:54 INFO - PID 31099 | RSS: Main: 169394176 10:24:54 INFO - PID 31099 | 10:24:55 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:56 INFO - PID 31099 | RSS: Main: 169525248 10:24:56 INFO - PID 31099 | 10:24:58 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:58 INFO - PID 31099 | RSS: Main: 169287680 10:24:58 INFO - PID 31099 | 10:25:00 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:01 INFO - PID 31099 | RSS: Main: 169287680 10:25:01 INFO - PID 31099 | 10:25:04 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:04 INFO - PID 31099 | RSS: Main: 169271296 10:25:04 INFO - PID 31099 | 10:25:08 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:08 INFO - PID 31099 | RSS: Main: 170082304 10:25:08 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | Cycle 1(1): loaded http://localhost:38569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38569/tests/kraken/driver.html?testName=ai-astar) 10:25:10 INFO - PID 31099 | RSS: Main: 171237376 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | __start_tp_report 10:25:10 INFO - PID 31099 | _x_x_mozilla_page_load 10:25:10 INFO - PID 31099 | _x_x_mozilla_page_load_details 10:25:10 INFO - PID 31099 | |i|pagename|runs| 10:25:10 INFO - PID 31099 | |0;ai-astar;109;111;112;113;113;115;113;110;113;114 10:25:10 INFO - PID 31099 | |1;audio-beat-detection;151;130;125;172;125;128;126;125;148;125 10:25:10 INFO - PID 31099 | |2;audio-dft;163;163;162;162;163;165;165;169;164;163 10:25:10 INFO - PID 31099 | |3;audio-fft;76;74;75;101;75;75;74;76;98;74 10:25:10 INFO - PID 31099 | |4;audio-oscillator;85;85;105;83;82;83;98;83;83;109 10:25:10 INFO - PID 31099 | |5;imaging-gaussian-blur;114;114;115;114;113;114;115;114;114;114 10:25:10 INFO - PID 31099 | |6;imaging-darkroom;152;150;152;152;150;150;151;150;152;150 10:25:10 INFO - PID 31099 | |7;imaging-desaturate;94;95;95;94;95;95;94;95;95;95 10:25:10 INFO - PID 31099 | |8;json-parse-financial;58;53;58;55;58;67;54;55;56;55 10:25:10 INFO - PID 31099 | |9;json-stringify-tinderbox;57;57;57;57;57;59;57;57;57;57 10:25:10 INFO - PID 31099 | |10;stanford-crypto-aes;82;95;82;84;81;82;82;82;92;82 10:25:10 INFO - PID 31099 | |11;stanford-crypto-ccm;133;134;137;132;132;138;135;135;176;131 10:25:10 INFO - PID 31099 | |12;stanford-crypto-pbkdf2;186;200;187;201;196;193;215;195;196;199 10:25:10 INFO - PID 31099 | |13;stanford-crypto-sha256-iterative;74;77;77;78;74;75;77;75;73;74 10:25:10 INFO - PID 31099 | __end_tp_report 10:25:10 INFO - PID 31099 | __start_cc_report 10:25:10 INFO - PID 31099 | _x_x_mozilla_cycle_collect,769 10:25:10 INFO - PID 31099 | __end_cc_report 10:25:10 INFO - PID 31099 | __startTimestamp1495387510813__endTimestamp 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | ------- Summary: start ------- 10:25:10 INFO - PID 31099 | Number of tests: 14 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.83 (1.6%) stddev-sans-first:1.50 10:25:10 INFO - PID 31099 | Values: 109.0 111.0 112.0 113.0 113.0 115.0 113.0 110.0 113.0 114.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:129.00 stddev:16.15 (12.5%) stddev-sans-first:16.12 10:25:10 INFO - PID 31099 | Values: 151.0 130.0 125.0 172.0 125.0 128.0 126.0 125.0 148.0 125.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.08 (1.3%) stddev-sans-first:2.18 10:25:10 INFO - PID 31099 | Values: 163.0 163.0 162.0 162.0 163.0 165.0 165.0 169.0 164.0 163.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#3] audio-fft Cycles:10 Average:79.80 Median:75.00 stddev:10.43 (13.9%) stddev-sans-first:10.97 10:25:10 INFO - PID 31099 | Values: 76.0 74.0 75.0 101.0 75.0 75.0 74.0 76.0 98.0 74.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:10.32 (12.4%) stddev-sans-first:10.81 10:25:10 INFO - PID 31099 | Values: 85.0 85.0 105.0 83.0 82.0 83.0 98.0 83.0 83.0 109.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:25:10 INFO - PID 31099 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 115.0 114.0 114.0 114.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:151.50 stddev:0.99 (0.7%) stddev-sans-first:0.97 10:25:10 INFO - PID 31099 | Values: 152.0 150.0 152.0 152.0 150.0 150.0 151.0 150.0 152.0 150.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 10:25:10 INFO - PID 31099 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:3.96 (6.9%) stddev-sans-first:4.18 10:25:10 INFO - PID 31099 | Values: 58.0 53.0 58.0 55.0 58.0 67.0 54.0 55.0 56.0 55.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 10:25:10 INFO - PID 31099 | Values: 57.0 57.0 57.0 57.0 57.0 59.0 57.0 57.0 57.0 57.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:82.00 stddev:4.90 (6.0%) stddev-sans-first:5.12 10:25:10 INFO - PID 31099 | Values: 82.0 95.0 82.0 84.0 81.0 82.0 82.0 82.0 92.0 82.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:135.00 stddev:13.43 (10.0%) stddev-sans-first:14.11 10:25:10 INFO - PID 31099 | Values: 133.0 134.0 137.0 132.0 132.0 138.0 135.0 135.0 176.0 131.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.80 Median:197.50 stddev:8.13 (4.1%) stddev-sans-first:7.63 10:25:10 INFO - PID 31099 | Values: 186.0 200.0 187.0 201.0 196.0 193.0 215.0 195.0 196.0 199.0 10:25:10 INFO - PID 31099 | 10:25:10 INFO - PID 31099 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.40 Median:76.00 stddev:1.71 (2.3%) stddev-sans-first:1.74 10:25:10 INFO - PID 31099 | Values: 74.0 77.0 77.0 78.0 74.0 75.0 77.0 75.0 73.0 74.0 10:25:10 INFO - PID 31099 | -------- Summary: end -------- 10:25:10 INFO - PID 31099 | 10:25:11 INFO - TEST-INFO | 31099: exit 0 10:25:11 INFO - TEST-OK | kraken | took 63808ms 10:25:11 INFO - SUITE-END | took 1182s 10:25:11 INFO - Completed test suite (00:19:42) 10:25:11 INFO - javascript benchmark 10:25:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6633.422363922768, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2685.6760615409194, 2690.798190135738, 2708.079253053961, 2725.3731641722416, 2743.2593199836037, 5104.157813960701, 5233.780860967413, 5241.42344342122, 5265.078611243031, 5295.020421222077, 5207.479252074791, 5234.92147617786, 5295.682259064459, 5317.308749862513, 5329.866753331169, 4653.162430762462, 4669.486356500774, 4686.414198225222, 4752.857414277577, 4786.138495070886, 4704.200285951397, 4722.126406614787, 4798.328234047236, 4804.303376010476, 4854.514548545152, 4541.409616749835, 4732.43210814701, 4762.023785124041, 4784.808607655689, 4796.3524924135145, 4671.743054132022, 4691.695039822434, 4705.388299521074, 4736.194846876005, 4757.476677565465, 4621.607163391116, 4665.836695715668, 4680.765961701902, 4710.4347478302825, 4757.476677565465, 5251.975864706384, 5266.4470230626, 5285.0, 5299.735013249322, 5334.733263336818, 5543.861403464905, 5628.212050312959, 5643.492085712305, 5688.459596338341, 5702.287214098238, 5749.82750517481, 5765.0, 5769.394213607595, 5772.826815195551, 5795.710214489301, 5287.682739035632, 5343.62594618373, 5343.732813359395, 5348.304720386325, 5349.518543331041, 5677.261955945701, 5800.88398232033, 5847.502962248172, 5905.782309538333, 5931.940680593225, 5560.666360018412, 5569.248151499496, 5574.052411090124, 5599.468050535193, 5610.214569960209, 5479.178123281539, 5513.641613295123, 5637.830865074055, 5673.06394444912, 5685.260916080883, 5553.333599968029, 5686.658800471985, 5688.089905615082, 5707.914381284284, 5715.371309155989, 5507.449255074461, 5592.804251851166, 5608.551315894719, 5614.887702245932, 5618.2415373924, 4592.908141837144, 4611.792469338888, 4614.077184563101, 4672.43930728308, 4678.789454474557, 4017.9598204017584, 4060.675145988314, 4075.8369665213654, 4084.9795751021056, 4110.34234522481, 4657.417822772153, 4697.154512187839, 4708.293755936637, 4716.103940251342, 4742.905141897143, 5575.498205161473, 5679.176519404663, 5683.914741278884, 5687.345955215121, 5741.339745929272, 4684.812607495662, 4709.105269998689, 4750.429948406213, 4756.7859446325, 4770.236762118045, 4997.575206107449, 5004.974975125101, 5010.69935803853, 5016.423111342169, 5054.0, 5227.503387178288, 5245.108331583716, 5260.263563101093, 5268.209768534597, 5269.683818970874, 5568.805091821767, 5653.660780353028, 5674.602777805514, 5760.942390576208, 5770.105633626795, 5297.390800058042, 5305.973470132624, 5310.734463276744, 5317.1492561190025, 5348.171033489815, 5586.720663966867, 5657.519110875622, 5658.915116273177, 5670.14938777956, 5696.601237913306, 5579.2746942897165, 5620.8875822482505, 5682.744276507649, 5722.74247658848, 5747.597668163356, 5578.665280083208, 5601.327840659147, 5610.158476228598, 5612.186232996274, 5625.606207565595, 5375.516203541543, 5530.972345138249, 5556.499915007668, 5573.693446860461, 5591.860203494945, 5362.705051222064, 5390.110631745718, 5484.725763711878, 5491.2312276282155, 5495.422980587141, 5461.863453413696, 5555.749991250323, 5599.300087489064, 5604.467575580314, 5612.045952188057, 5279.340082489689, 5374.596905232045, 5398.352197736297, 5414.187871819258, 5438.129899216106], "value": 5138.209589775095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.0886793960216, 713.5326361233392, 725.231254869838, 1148.8908553687402, 1179.5517703272756, 35485.2902941941, 36432.817835910784, 36614.8169259154, 36636.63363366365, 36662.816685916565, 34786.47820282691, 34835.0, 34853.477197842054, 34940.301193976105, 35184.47223291652, 6651.800445986628, 6789.422899053587, 6845.110135682379, 7094.68073936674, 7139.0, 7022.82442938928, 7071.575705457663, 7115.430765538745, 7127.857442851166, 7140.714371425137, 7089.680964356617, 7141.714331426762, 7147.178074521418, 7164.749233776819, 7168.462365322595, 7084.220735719066, 7097.325754053382, 7114.110736157981, 7139.286071392871, 7154.356107950257, 7047.577145371294, 7067.8586428271665, 7111.53775004623, 7111.644417779142, 7142.607156606385, 33575.49636755451, 33598.83200584006, 33748.32503349919, 33868.661313386794, 33893.83053084744, 2799.622051023106, 2801.523740964021, 2821.2523681224493, 2832.730890565393, 2848.2309776360266, 22384.55230895389, 22439.0, 22473.550528989494, 22566.323010309552, 22584.096636134534, 2958.4970555005702, 2960.319126600872, 2988.208124846917, 2989.282572182682, 2989.387175628991, 143513.2824335882, 143688.28155859155, 143934.0, 151162.0, 156659.0, 41028.0, 41252.587474125474, 41585.79207104006, 41620.79189604093, 41621.0, 42621.36067958983, 42676.0, 42752.57247427548, 47778.761106194244, 47838.0, 13455.32723363828, 13637.590872273848, 13644.0, 13668.794968075486, 13689.178649281075, 10781.622643207607, 10812.243142980073, 10855.891441085647, 10869.184811139037, 10872.130229581615, 13313.334333283297, 13315.201087934562, 13368.064235503422, 13467.86532134666, 13523.0, 5474.890502189934, 5542.91685624716, 5577.191307260506, 5611.663300202001, 5628.943710562842, 831.4637059096849, 867.6225841758855, 890.7594949363636, 905.9320550958572, 908.8318661047728, 19579.216831326874, 20560.58878822415, 20734.06696698652, 20766.688499672517, 20766.896165519076, 951.6383774165772, 968.9757756056155, 985.5909797433984, 994.3238597753452, 995.2983146881576, 10572.682819515427, 10811.83782243267, 10851.294665846695, 10855.968682975104, 10947.726306842393, 189381.0, 190339.0, 190808.0, 191101.0, 191911.0, 43029.0, 43250.0, 43334.0, 43425.565744342784, 43447.78276108662, 1181.1023622047264, 1226.6994586326407, 1226.920250183735, 1232.6979889927024, 1248.7003119251315, 19179.136938837506, 19410.126544305822, 19419.8058019418, 20165.193392264733, 20434.182632694527, 30868.691313086583, 39490.802545987084, 40142.18649228319, 40191.0, 40471.59528404678, 169932.0, 171050.0, 171893.0, 172373.0, 172852.0, 31239.68760312368, 31390.843045784626, 31434.685653143177, 31442.0, 31746.365072697954, 37066.25867482581, 37693.434598481595, 38297.425538616386, 38300.6169938297, 38332.80833595814, 28994.42011159723, 29004.854975724986, 29346.70653293525, 29680.851595742748, 29876.253093672833, 28443.28891777722, 28557.571636425884, 28842.42315153727, 29849.0, 29871.551926720684, 31840.68159318377, 31960.0, 32058.6794132065, 32203.677963220067, 32274.515882262254, 27003.1899043029, 27480.312992174557, 28124.156275311772, 28314.2921426966, 28745.28136796513, 20358.79641203569, 22924.19765308206, 23117.65323520115, 23185.188518401774, 23375.0], "value": 14959.232967485841, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.0903575989782, 410.6427408154906, 417.13444602449914, 426.92528807458706, 427.9229738647043, 17151.0, 17776.733348999776, 17808.643827123466, 17987.820121798777, 18674.906625466887, 18912.1489532971, 18912.338068167617, 19077.332293369735, 19099.71350429741, 19151.23395064196, 5290.55030322423, 5309.761060752266, 5455.672659640434, 5476.972615136939, 5480.671159730409, 5346.812861549846, 5382.111951527993, 5427.782888684448, 5435.912817436529, 5443.618946673734, 5225.634205605609, 5305.734713264322, 5330.38700549436, 5336.9733151334185, 5386.0, 5321.760520776575, 5370.382406023279, 5376.38171610264, 5377.7311134443125, 5388.515033646951, 4696.8590942271785, 4845.63657725672, 4847.394075740533, 4859.611231101503, 4880.877978050577, 21231.36305910825, 21250.14999400022, 21486.892565537073, 21500.139994400204, 21538.89230553837, 1619.6679680665436, 1661.460025491708, 1663.3429795230936, 1663.3928616055173, 1670.1649175412294, 13089.934550327283, 13534.187948723009, 13678.521251756141, 13696.589102326947, 13822.239776812272, 1814.6461440019202, 1815.9631428215664, 1847.6397102565006, 1862.4040307101732, 1880.4640677406874, 78650.0, 80758.19241807566, 81304.59347703223, 81493.59253203755, 81543.9999999994, 10223.233257505568, 10670.51982660782, 10703.411312377893, 10770.299930504492, 10818.891811081945, 14225.430982760781, 14340.498082567061, 14347.497837575635, 14349.78475322871, 14490.637734056521, 7406.518576292524, 7603.619819009027, 7664.118626357928, 7889.250521200477, 7902.960485197537, 7194.244604316576, 7290.9635451822405, 7305.634718264066, 7495.250474952571, 7506.812329691692, 6861.0, 6891.3797758202, 6981.127359080115, 7003.124609423822, 7024.4029257513685, 1898.4874083997242, 1914.3012800328058, 1944.8735832170864, 1967.5538479217764, 1974.5557249619008, 854.107457706698, 894.9731508054768, 897.4032268541347, 901.193431878465, 924.8751418558409, 16911.661766764842, 17076.743848842278, 17594.824051759573, 17798.822011779717, 17922.19350129221, 889.7731078575051, 901.1709227510706, 901.8376692195336, 909.4316052467208, 911.3028533172129, 9166.427105740599, 9369.953150234205, 9739.123478886933, 9773.0, 9862.309638325249, 352676.0, 358776.0, 358908.0, 360188.0, 369212.0, 72975.88200119635, 73517.63241183759, 73884.63057684677, 75876.62061689766, 77298.61350693322, 1056.6513050693252, 1069.7593041565585, 1089.5805115030612, 1094.7974624694457, 1096.6929259807266, 16974.0, 18142.274309027493, 18447.815521844608, 18453.630927381644, 18628.534286642942, 37808.243835122594, 38058.61941380661, 38272.61727382802, 38560.80719596384, 38838.0, 47027.52972470369, 47627.76186119047, 48251.27623085727, 48933.51066489289, 49058.0, 8133.0, 8253.298469630148, 8266.090730019572, 8352.582370881553, 8494.53280069602, 12734.363281836057, 12735.426905789076, 13075.803862941873, 13090.869091308965, 13338.399772010089, 11304.660860174208, 11305.886941130484, 11426.0, 11579.88420115788, 11620.418979050844, 10103.24225683062, 10362.326448780805, 10493.47532623381, 10537.789244215226, 10559.89121142269, 11059.612913547988, 11081.667549973514, 11195.832062519232, 11237.157213209206, 11542.884571154182, 8086.5148091114725, 8126.187381261827, 8256.25693687547, 8432.662693492437, 8500.659973600987, 11187.664370068911, 11215.66353009411, 11336.716582085513, 11520.769584608428, 11577.421128943688], "value": 8761.517496232715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.297020698202, 1247.8939290160336, 1285.3316275536715, 1286.2989670629506, 1299.7595444842705, 9485.715428537147, 9832.705018849438, 9845.852312215322, 10063.748406289846, 10357.0, 10209.693709188718, 10337.638182663608, 10339.948300258508, 10367.170626349875, 10368.377897326165, 2046.4167712202025, 2081.708560801489, 2093.3196711068886, 2093.58128374325, 2114.577084583082, 2091.943568497914, 2141.550274442369, 2142.3787101740554, 2155.665871789875, 2176.923807666732, 2167.2847960173103, 2175.5213852952324, 2204.360735386736, 2214.3135627955303, 2245.6743772153027, 2101.107029512451, 2102.8317734581196, 2123.543438160803, 2130.936071917845, 2148.6239908016037, 1977.0905383523452, 2041.4181958142008, 2094.6124966881175, 2110.9577808443746, 2133.4986278224605, 9507.57215925285, 9581.0, 9593.664221752206, 9602.327837051409, 9609.855852162224, 5333.306670132897, 5497.147942068946, 5508.91736623951, 5541.501264886179, 5542.473465020857, 3032.7270545651, 3122.5160100184507, 3178.7933784303946, 3225.3549290142064, 3225.758068144875, 1015.1878497202282, 1024.8257796174669, 1042.5152304178519, 1070.1278458056659, 1072.3673032910542, 14146.858531414657, 14214.85785142156, 14246.0, 14323.856761432357, 14329.283535823271, 4472.932906006413, 4603.516630753789, 4754.358161648202, 4788.209945358977, 4819.807207711652, 10012.499375031219, 10015.298929074896, 10042.849357259647, 10063.798724025479, 10074.949625251973, 5382.730863456812, 5390.676559406448, 5411.83764487066, 5431.429699881534, 5443.0, 4825.4933232010835, 5047.470015648378, 5057.873553161126, 5133.050385678662, 5143.639945203875, 3684.834182461742, 3761.3417651910804, 3781.8865434037025, 3844.2119365529998, 3856.46009558662, 1025.9743506412399, 1032.7779527401494, 1033.426448321174, 1038.8935783390664, 1042.8696412948382, 665.238302144052, 684.8835697931364, 695.0755495191383, 705.28413660135, 712.0565251042286, 4957.652964292465, 4975.378077740283, 5010.724410157476, 5176.301199338041, 5470.9452905471235, 505.10092036175666, 516.3107251818789, 517.350724840323, 518.7872972081428, 519.6310619460226, 3039.6960303969868, 3063.0, 3272.9181770455452, 3418.2821607462215, 3419.4528875380315, 12379.62861114168, 12883.420246088948, 12895.161814482217, 12913.160644558073, 12916.483340666457, 12497.0, 12634.368281585885, 12676.112672113048, 12682.302473364054, 12854.0, 6752.696128674222, 6856.90289553669, 6857.245702972669, 6922.134733158356, 7035.190953040364, 5289.444608316071, 5296.973515132399, 5306.336707911511, 5752.482276595127, 5953.493953014043, 11198.21612487118, 11463.484143213409, 11468.369239691898, 11472.483738231633, 11701.590444334408, 11575.363355015219, 11732.765344693229, 11764.764704705687, 11882.227655202385, 11892.524299028288, 7968.7609371718945, 8037.557934313435, 8040.758777236459, 8133.0, 8196.713115041184, 9009.684661036832, 9154.542272886461, 9207.447553146832, 9218.0, 9227.431336672917, 7908.802279943047, 7921.881171782313, 8044.839103217786, 8081.0, 8091.83816323682, 7645.1972542882195, 7773.4169937256065, 7786.922130778847, 7820.061592608923, 7972.561509116822, 6834.179898412222, 7037.859242815218, 7047.295270473117, 7048.471364647569, 7049.541779784297, 4878.780454879468, 4889.242167464049, 4911.533404326583, 4940.283658869372, 4999.350084488993, 4906.533879281463, 4984.32711583946, 5034.773435195351, 5042.974785126051, 5137.92293115611], "value": 4478.816982566351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.2117329501514, 383.7141329709367, 389.978551179685, 395.05581659832995, 397.0391652201673, 5491.917621235674, 5641.420402287361, 5650.406707295737, 5663.207150998858, 5682.4601662842015, 5390.8921821563545, 5470.839018587655, 5482.205080263359, 5505.862353441166, 5512.255845460862, 4163.271427500198, 4163.583641635827, 4164.354525048622, 4185.476815398075, 4197.118605092935, 4121.958780412202, 4170.249355116093, 4174.31123864562, 4202.201581699483, 4206.284931561627, 4119.814608342632, 4120.093579412524, 4122.083231297446, 4124.566920473352, 4161.167766446722, 4103.2409004333995, 4111.650509706664, 4126.133511962492, 4139.254934111858, 4168.374743788456, 3545.3441113393847, 3606.7114630829733, 3608.0, 3614.313280476701, 3616.0, 5329.520343169094, 5359.919601205985, 5394.7842086316505, 5415.214793854869, 5424.403315635277, 4814.15752243356, 4817.325574419584, 4830.299606557065, 4840.636952228561, 4842.757862106916, 5665.66006039639, 5749.252597162342, 5821.7380217890295, 5843.328017278025, 5844.386339434341, 3986.46859244379, 3989.940150897739, 3992.201559688045, 3997.2205419943125, 4012.8394864205397, 5939.168516407706, 6113.908291375633, 6154.5384096192965, 6167.907481387782, 6175.691215439255, 4064.309067458539, 4064.7967601619803, 4087.693422993228, 4101.507819061731, 4106.0, 4160.729552579072, 4172.0, 4178.22702799983, 4178.937315940263, 4182.2890108681595, 4708.4349878014855, 4807.423109226916, 4839.28205487054, 4846.151923413388, 4850.927236091461, 5782.710864456844, 5791.681457519792, 5799.0, 5813.273340832396, 5887.4406931341455, 1417.971640567183, 1430.4850253908585, 1436.174199835099, 1436.913785172893, 1443.408202636935, 930.3394589841154, 957.5260246178186, 961.1061712607342, 963.691618682029, 967.7870868408938, 4844.75776211188, 4876.8780780480065, 4885.828995985124, 4900.166971614834, 4902.779374928136, 5961.2846458425265, 6005.489533389624, 6008.218931538872, 6020.488258498077, 6044.335123136451, 4708.646851486153, 4833.685810422311, 4837.830675926396, 4868.269759536027, 4886.729450342866, 3130.1235654016914, 3147.1502694272876, 3147.1660010097344, 3172.8419127018933, 3176.936461270762, 5423.647462914898, 5531.695756733418, 5536.141898005735, 5541.0580201365865, 5552.500824777288, 6073.878522429527, 6087.57386982907, 6113.23584551931, 6148.1392605035335, 6148.78479253224, 5510.6969116698965, 5524.475174858382, 5557.194206839986, 5572.944270557324, 5602.459323685856, 5804.65172089676, 6013.488853447506, 6021.2473440819895, 6026.7589296429405, 6080.847978800389, 5934.9406505934385, 5957.553183511341, 5966.164736936919, 5983.9401605983385, 6002.939970600412, 5427.918581221364, 5592.273004509388, 5604.656391296778, 5608.775648973995, 5619.578531610064, 4064.800883739363, 4075.0423650442717, 4095.488063992001, 4113.321301985139, 4117.135401565704, 5895.29256489224, 6079.422454866957, 6092.329843717276, 6130.816075517741, 6139.447449729546, 5878.617889837147, 5892.1161825726485, 5903.616264942765, 5907.379725128972, 5922.466977972003, 5871.295444546511, 5890.617109887844, 5898.587098903035, 5902.940970590411, 5910.7931222407005, 5738.1679656450415, 5745.540356771365, 5802.593818432669, 5828.60113572748, 5839.795607153899, 5905.527557795452, 5913.438223368773, 5930.436608522184, 5938.594869078031, 5939.287285525765, 5581.665100094007, 5726.420986883198, 5737.225474560881, 5748.252727145445, 5771.59598828078], "value": 4336.56097264744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.6138162628928, 700.6111608057525, 700.8177873752823, 701.5404909784091, 710.3145464626638, 12683.746325073493, 13098.869011309873, 13102.803457948126, 13591.320433978286, 13936.581902542915, 14274.857251427482, 14323.427062917497, 14374.784378234308, 14392.64018399538, 14426.495072672458, 911.9133682300171, 920.8802855628759, 926.8934072581671, 929.8140371925608, 931.8741969834088, 920.0569416348263, 923.487464457226, 924.191332583989, 925.6575067225136, 930.4277869110482, 952.5808644196566, 958.0706714486937, 958.8226178157063, 959.472290240365, 963.9518024098802, 954.8806399200065, 957.621739412935, 958.5542722633974, 960.1358777100666, 970.6311601591385, 635.7425242776683, 670.269406347084, 678.2098854834112, 709.7551344786092, 716.4125417157933, 14099.50651727195, 14245.501407450689, 14260.286985650677, 14298.0, 14325.856741432557, 13244.404001819941, 13841.930790346085, 13990.370433330525, 14022.509212177525, 14078.08492447998, 10185.490725463771, 10460.63387781424, 10590.046895779416, 10756.085732712729, 10764.677059688222, 2853.1583182961076, 2854.8287102773693, 2870.7129287071334, 2872.8994485193125, 2878.29481776966, 68794.0, 69630.65184674095, 70312.94530582096, 71013.64493177501, 72190.63904680443, 10834.0, 11279.830802537968, 11306.830397544043, 11462.770744585228, 11560.0, 20452.897735511226, 20567.691484627743, 20728.378148655564, 20978.580428391346, 21037.68443473349, 5726.79956201531, 5879.647221166743, 5910.8817823643285, 5914.0537513998415, 5936.020556608198, 2741.684706258766, 2765.184270640166, 2790.037437084203, 2792.2181789099086, 2793.6228609137506, 3423.845926933294, 3427.725781937439, 3452.1369657585606, 3509.052555809968, 3511.754177207571, 691.0463560286772, 693.7918624412656, 698.8287869472011, 700.9018737376771, 704.4188544450747, 529.1190168369699, 544.77119609764, 552.1689856765543, 552.4806681719172, 555.5860883641712, 8942.284617230736, 9244.491552964517, 9492.620295188253, 9668.70993870185, 9692.273079519064, 495.93552838131535, 500.32706010415933, 504.06747517093083, 516.1406258579498, 524.0043916558493, 4002.459667944848, 4139.068709540329, 4149.315362965137, 4158.6465150461945, 4263.936040959388, 58372.70813645905, 59402.0, 59529.70235148796, 61005.38994609997, 62104.37895620986, 56294.437055629736, 56318.71840640771, 56375.15437268444, 56632.0, 57148.0, 50184.749076253654, 51218.74390628023, 51476.22785658218, 51546.22680659718, 52134.0, 8451.535165565952, 8455.323574113932, 8496.065432802263, 8559.272461840814, 8661.177188167114, 24367.0, 24438.51122977566, 24656.1370352044, 25888.741112588632, 26341.473170536865, 41396.37905431481, 41627.95930101772, 42824.0, 43216.0, 43511.0, 12395.318257495564, 12575.622731318075, 12761.0, 12858.807117893051, 12867.678308042374, 13934.790978135134, 13947.442102315794, 14128.717425651224, 14254.928725356722, 14547.636309092357, 12661.746765064463, 12819.487220511075, 12983.740325193632, 13121.803172952223, 13199.20804751718, 12319.63041108768, 12349.629511114681, 12473.625791226277, 12485.687857803627, 12592.811107833573, 12927.030472714396, 12947.093703440669, 13016.0, 13036.348182590642, 13077.149985250928, 9457.29070319715, 10092.394456332644, 10128.848067279145, 10204.0, 10557.947210264207, 10399.844002340122, 10688.679339619825, 10902.618408355669, 10924.352992782371, 10980.121590272918], "value": 6513.022422395992, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 112.0, 113.0, 113.0, 115.0, 113.0, 110.0, 113.0, 114.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 125.0, 172.0, 125.0, 128.0, 126.0, 125.0, 148.0, 125.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 165.0, 165.0, 169.0, 164.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 101.0, 75.0, 75.0, 74.0, 76.0, 98.0, 74.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 83.0, 82.0, 83.0, 98.0, 83.0, 83.0, 109.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 152.0, 152.0, 150.0, 150.0, 151.0, 150.0, 152.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 58.0, 55.0, 58.0, 67.0, 54.0, 55.0, 56.0, 55.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 59.0, 57.0, 57.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 95.0, 82.0, 84.0, 81.0, 82.0, 82.0, 82.0, 92.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 137.0, 132.0, 132.0, 138.0, 135.0, 135.0, 176.0, 131.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 200.0, 187.0, 201.0, 196.0, 193.0, 215.0, 195.0, 196.0, 199.0], "value": 196.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 78.0, 74.0, 75.0, 77.0, 75.0, 73.0, 74.0], "value": 75.4, "unit": "score"}]}]} 10:25:12 INFO - Return code: 0 10:25:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:12 INFO - # TBPL SUCCESS # 10:25:12 INFO - Running post-action listener: _resource_record_post_action 10:25:12 INFO - [mozharness: 2017-05-21 17:25:12.105885Z] Finished run-tests step (success) 10:25:12 INFO - Running post-run listener: _resource_record_post_run 10:25:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 16384; Write bytes: 400556032; Read time: 284; Write time: 718412 10:25:12 INFO - TinderboxPrint: CPU usage
13.3% 10:25:12 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 284 10:25:12 INFO - TinderboxPrint: I/O write bytes / time
400,556,032 / 718,412 10:25:12 INFO - TinderboxPrint: CPU idle
8,294.6 (86.7%) 10:25:12 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 10:25:12 INFO - TinderboxPrint: Swap in / out
0 / 0 10:25:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 73252864; Read time: 0; Write time: 112024 10:25:12 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 302264320; Read time: 252; Write time: 472360 10:25:12 INFO - Running post-run listener: _upload_blobber_files 10:25:12 INFO - Blob upload gear active. 10:25:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:12 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 10:25:12 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:12 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:25:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:25:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:25:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:14 INFO - (blobuploader) - INFO - Done attempting. 10:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:25:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:17 INFO - (blobuploader) - INFO - Done attempting. 10:25:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:25:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:18 INFO - (blobuploader) - INFO - Done attempting. 10:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:25:19 INFO - (blobuploader) - INFO - Done attempting. 10:25:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:25:19 INFO - Return code: 0 10:25:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:25:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:25:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47b6fe334ae6f29a7defcb48f8a73a69088b34efdb6e009f81f05a7699bea9a3f24e3df83f1c8fbf9a1c25d8b0ee0358923c32fadf98b4ec5b2bb87525784f9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8836790d842951b527b78b0f9076a8799848711cf981bc7b93b8fa88916906cff8f4c2d51cd320caee75cb23cc665377818b7c5a2b6587c6896589afb034755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2c4509ee819e5773a379df5d3c60c8514c1fdd3da2df1545716723994708e9f31eeb3b79001774f54fc7b5ef5083243051b112fe010e53c2229ff035164a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4486418977faeda375985a0fe8f44238e724321b3bb834d4367b0a08f49cc481403bfcde91eaadbec0005ecd2314b6ebf21f3f49806fa73c9d7a6921cc1de4b0"} 10:25:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:25:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:25:19 INFO - Contents: 10:25:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47b6fe334ae6f29a7defcb48f8a73a69088b34efdb6e009f81f05a7699bea9a3f24e3df83f1c8fbf9a1c25d8b0ee0358923c32fadf98b4ec5b2bb87525784f9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8836790d842951b527b78b0f9076a8799848711cf981bc7b93b8fa88916906cff8f4c2d51cd320caee75cb23cc665377818b7c5a2b6587c6896589afb034755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2c4509ee819e5773a379df5d3c60c8514c1fdd3da2df1545716723994708e9f31eeb3b79001774f54fc7b5ef5083243051b112fe010e53c2229ff035164a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4486418977faeda375985a0fe8f44238e724321b3bb834d4367b0a08f49cc481403bfcde91eaadbec0005ecd2314b6ebf21f3f49806fa73c9d7a6921cc1de4b0"} 10:25:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:25:19 INFO - Copying logs to upload dir... 10:25:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:25:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.596757 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-21 10:25:19.084647) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 10:25:19.092257) ========= 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=8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47b6fe334ae6f29a7defcb48f8a73a69088b34efdb6e009f81f05a7699bea9a3f24e3df83f1c8fbf9a1c25d8b0ee0358923c32fadf98b4ec5b2bb87525784f9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8836790d842951b527b78b0f9076a8799848711cf981bc7b93b8fa88916906cff8f4c2d51cd320caee75cb23cc665377818b7c5a2b6587c6896589afb034755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2c4509ee819e5773a379df5d3c60c8514c1fdd3da2df1545716723994708e9f31eeb3b79001774f54fc7b5ef5083243051b112fe010e53c2229ff035164a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4486418977faeda375985a0fe8f44238e724321b3bb834d4367b0a08f49cc481403bfcde91eaadbec0005ecd2314b6ebf21f3f49806fa73c9d7a6921cc1de4b0"} build_url:https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/PWFcMnYUSCCOcLDu6SCchg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/47b6fe334ae6f29a7defcb48f8a73a69088b34efdb6e009f81f05a7699bea9a3f24e3df83f1c8fbf9a1c25d8b0ee0358923c32fadf98b4ec5b2bb87525784f9c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d8836790d842951b527b78b0f9076a8799848711cf981bc7b93b8fa88916906cff8f4c2d51cd320caee75cb23cc665377818b7c5a2b6587c6896589afb034755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a2c4509ee819e5773a379df5d3c60c8514c1fdd3da2df1545716723994708e9f31eeb3b79001774f54fc7b5ef5083243051b112fe010e53c2229ff035164a1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4486418977faeda375985a0fe8f44238e724321b3bb834d4367b0a08f49cc481403bfcde91eaadbec0005ecd2314b6ebf21f3f49806fa73c9d7a6921cc1de4b0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 10:25:19.119101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:25:19.119424) ========= 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=8783db0840cc980e80bb0bd400000236-1495385271.126364-957819610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 10:25:19.198633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 10:25:19.201966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 10:25:19.202266) ========= ========= Total master_lag: 0.20 =========