builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1501162893.16 results: success (0) revision: 658cba6a971257e2ba39715ec938256dfc414776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.159176) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.159606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.159893) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.181739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.182008) ========= 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=3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 06:41:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-07-27 06:41:33 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.290554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.290879) ========= 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=3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021047 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.340544) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:33.340852) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 658cba6a971257e2ba39715ec938256dfc414776 --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 658cba6a971257e2ba39715ec938256dfc414776 --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=3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 06:41:33,476 truncating revision to first 12 chars 2017-07-27 06:41:33,476 Setting DEBUG logging. 2017-07-27 06:41:33,476 attempt 1/10 2017-07-27 06:41:33,476 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/658cba6a9712?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 06:41:33,799 unpacking tar archive at: mozilla-central-658cba6a9712/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703512 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:34.058022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:34.058303) ========= script_repo_revision: 658cba6a971257e2ba39715ec938256dfc414776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:34.058674) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:34.059024) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:34.067574) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-07-27 06:41:34.067878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:41:34 INFO - MultiFileLogger online at 20170727 06:41:34 in /builds/slave/test 06:41:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:41:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:34 INFO - {'append_to_log': False, 06:41:34 INFO - 'base_work_dir': '/builds/slave/test', 06:41:34 INFO - 'blob_upload_branch': 'Firefox', 06:41:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:34 INFO - 'branch': 'Firefox', 06:41:34 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:34 INFO - 'code_coverage': False, 06:41:34 INFO - 'config_files': ('talos/linux_config.py',), 06:41:34 INFO - 'default_actions': ('clobber', 06:41:34 INFO - 'read-buildbot-config', 06:41:34 INFO - 'download-and-extract', 06:41:34 INFO - 'populate-webroot', 06:41:34 INFO - 'create-virtualenv', 06:41:34 INFO - 'install', 06:41:34 INFO - 'setup-mitmproxy', 06:41:34 INFO - 'run-tests'), 06:41:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:34 INFO - 'disable_ccov_upload': False, 06:41:34 INFO - 'download_minidump_stackwalk': True, 06:41:34 INFO - 'download_symbols': 'ondemand', 06:41:34 INFO - 'enable_stylo': False, 06:41:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:34 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:34 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:34 INFO - 'gecko_profile': False, 06:41:34 INFO - 'gecko_profile_interval': 0, 06:41:34 INFO - 'installer_path': 'installer.exe', 06:41:34 INFO - 'log_level': 'info', 06:41:34 INFO - 'log_name': 'talos', 06:41:34 INFO - 'log_to_console': True, 06:41:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:41:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:41:34 INFO - 'opt_config_files': (), 06:41:34 INFO - 'pip_index': False, 06:41:34 INFO - 'suite': 'dromaeojs-e10s', 06:41:34 INFO - 'system_bits': '32', 06:41:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:34 INFO - 'title': 'talos-linux64-ix-030', 06:41:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:34 INFO - 'use_talos_json': True, 06:41:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:34 INFO - 'work_dir': 'build'} 06:41:34 INFO - [mozharness: 2017-07-27 13:41:34.302254Z] Running clobber step. 06:41:34 INFO - Running pre-action listener: _resource_record_pre_action 06:41:34 INFO - Running main action method: clobber 06:41:34 INFO - rmtree: /builds/slave/test/build 06:41:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:35 INFO - Running post-action listener: _resource_record_post_action 06:41:35 INFO - [mozharness: 2017-07-27 13:41:35.342406Z] Finished clobber step (success) 06:41:35 INFO - [mozharness: 2017-07-27 13:41:35.342509Z] Running read-buildbot-config step. 06:41:35 INFO - Running pre-action listener: _resource_record_pre_action 06:41:35 INFO - Running main action method: read_buildbot_config 06:41:35 INFO - Using buildbot properties: 06:41:35 INFO - { 06:41:35 INFO - "project": "", 06:41:35 INFO - "product": "firefox", 06:41:35 INFO - "who": "archaeopteryx@coole-files.de", 06:41:35 INFO - "installer_path": "public/build/target.tar.bz2", 06:41:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 06:41:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:41:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 06:41:35 INFO - "stage_platform": "linux64-stylosequential", 06:41:35 INFO - "basedir": "/builds/slave/test", 06:41:35 INFO - "buildnumber": 152, 06:41:35 INFO - "platform": "ubuntu64_hw_styloseq", 06:41:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:41:35 INFO - "slavebuilddir": "test", 06:41:35 INFO - "taskId": "aXTVwZdLSGOWRIuhRq_9Ww", 06:41:35 INFO - "branch": "mozilla-central", 06:41:35 INFO - "script_repo_revision": "production", 06:41:35 INFO - "revision": "658cba6a971257e2ba39715ec938256dfc414776", 06:41:35 INFO - "slavename": "talos-linux64-ix-030", 06:41:35 INFO - "repo_path": "mozilla-central" 06:41:35 INFO - } 06:41:35 INFO - Finding installer, test and symbols from parent task. 06:41:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aXTVwZdLSGOWRIuhRq_9Ww'}, attempt #1 06:41:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aXTVwZdLSGOWRIuhRq_9Ww'}, attempt #1 06:41:36 INFO - Task dependencies: NOjUXIa0QK-7lZYie13cWw 06:41:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw'}, attempt #1 06:41:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:41:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/test_packages.json 06:41:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip 06:41:36 INFO - Running post-action listener: _resource_record_post_action 06:41:36 INFO - [mozharness: 2017-07-27 13:41:36.748625Z] Finished read-buildbot-config step (success) 06:41:36 INFO - [mozharness: 2017-07-27 13:41:36.748849Z] Running download-and-extract step. 06:41:36 INFO - Running pre-action listener: _resource_record_pre_action 06:41:36 INFO - Running main action method: download_and_extract 06:41:36 INFO - mkdir: /builds/slave/test/build/tests 06:41:36 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')]} 06:41:36 INFO - trying https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.test_packages.json 06:41:36 INFO - Downloading https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:41:37 INFO - Downloaded 989 bytes. 06:41:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:41:37 INFO - Using the following test package requirements: 06:41:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:41:37 INFO - u'common': [u'target.common.tests.zip'], 06:41:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:41:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:41:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:41:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:41:37 INFO - u'mozbase': [u'target.common.tests.zip'], 06:41:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:41:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:41:37 INFO - u'web-platform': [u'target.common.tests.zip', 06:41:37 INFO - u'target.web-platform.tests.tar.gz'], 06:41:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:41:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:41:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip 06:41:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:41:37 INFO - Fetch https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip into memory 06:41:38 INFO - Content-Length response header: 72550620 06:41:38 INFO - Bytes received: 72550620 06:41:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:41:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip 06:41:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:41:49 INFO - Fetch https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip into memory 06:41:51 INFO - Content-Length response header: 72550620 06:41:51 INFO - Bytes received: 72550620 06:42:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.talos.tests.zip 06:42:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:42:04 INFO - Fetch https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.talos.tests.zip into memory 06:42:05 INFO - Content-Length response header: 14496465 06:42:05 INFO - Bytes received: 14496465 06:42: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')]} 06:42:05 INFO - trying https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:42:06 INFO - Downloaded 62082698 bytes. 06:42:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:42:06 INFO - mkdir: /builds/slave/test/properties 06:42:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:06 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:06 INFO - Contents: 06:42:06 INFO - build_url:https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:42:06 INFO - Running post-action listener: _resource_record_post_action 06:42:06 INFO - Running post-action listener: set_extra_try_arguments 06:42:06 INFO - [mozharness: 2017-07-27 13:42:06.432149Z] Finished download-and-extract step (success) 06:42:06 INFO - [mozharness: 2017-07-27 13:42:06.432247Z] Running populate-webroot step. 06:42:06 INFO - Running pre-action listener: _resource_record_pre_action 06:42:06 INFO - Running main action method: populate_webroot 06:42:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:42:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:42:06 INFO - 'tests': ['damp', 'tps']}, 06:42:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:42:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:42:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:42:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:06 INFO - 'ts_paint', 06:42:06 INFO - 'tpaint', 06:42:06 INFO - 'sessionrestore', 06:42:06 INFO - 'sessionrestore_many_windows', 06:42:06 INFO - 'sessionrestore_no_auto_restore', 06:42:06 INFO - 'tabpaint']}, 06:42:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:42:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:42:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:42:06 INFO - 'talos_options': ['--mitmproxy', 06:42:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:42:06 INFO - '--firstNonBlankPaint'], 06:42:06 INFO - 'tests': ['quantum_pageload_google', 06:42:06 INFO - 'quantum_pageload_youtube', 06:42:06 INFO - 'quantum_pageload_amazon', 06:42:06 INFO - 'quantum_pageload_facebook']}, 06:42:06 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:42:06 INFO - 'talos_options': ['--stylo', 06:42:06 INFO - '--mitmproxy', 06:42:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:42:06 INFO - '--firstNonBlankPaint'], 06:42:06 INFO - 'tests': ['quantum_pageload_google', 06:42:06 INFO - 'quantum_pageload_youtube', 06:42:06 INFO - 'quantum_pageload_amazon', 06:42:06 INFO - 'quantum_pageload_facebook']}, 06:42:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:06 INFO - 'tsvgr_opacity', 06:42:06 INFO - 'tart', 06:42:06 INFO - 'tscrollx', 06:42:06 INFO - 'cart', 06:42:06 INFO - 'tsvg_static']}, 06:42:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:42:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:42:06 INFO - 'talos_options': ['--xperf_path', 06:42:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:06 INFO - 'tests': ['tp5n']}}} 06:42:06 INFO - Running post-action listener: _resource_record_post_action 06:42:06 INFO - [mozharness: 2017-07-27 13:42:06.439570Z] Finished populate-webroot step (success) 06:42:06 INFO - [mozharness: 2017-07-27 13:42:06.439662Z] Running create-virtualenv step. 06:42:06 INFO - Running pre-action listener: _resource_record_pre_action 06:42:06 INFO - Running main action method: create_virtualenv 06:42:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:06 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 06:42:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:42:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:06 INFO - Using real prefix '/usr' 06:42:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:42:09 INFO - Installing pip.................done. 06:42:09 INFO - Return code: 0 06:42:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:42:09 INFO - Reading from file tmpfile_stdout 06:42:09 INFO - Output received: 06:42:09 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) 06:42:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:42:09 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')]} 06:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:09 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')]} 06:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:09 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:09 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 06:42:09 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 06:42:09 INFO - Using env: {'DISPLAY': ':0', 06:42:09 INFO - 'HOME': '/home/cltbld', 06:42:09 INFO - 'LANG': 'en_US.UTF-8', 06:42:09 INFO - 'LANGUAGE': 'en_US:en', 06:42:09 INFO - 'LOGNAME': 'cltbld', 06:42:09 INFO - 'MAIL': '/var/mail/cltbld', 06:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:09 INFO - 'MOZ_NO_REMOTE': '1', 06:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:09 INFO - 'NO_EM_RESTART': '1', 06:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:09 INFO - 'PWD': '/builds/slave/test', 06:42:09 INFO - 'SHELL': '/bin/bash', 06:42:09 INFO - 'SHLVL': '1', 06:42:09 INFO - 'TERM': 'linux', 06:42:09 INFO - 'TMOUT': '86400', 06:42:09 INFO - 'USER': 'cltbld', 06:42:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:09 INFO - '_': '/tools/buildbot/bin/python'} 06:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:09 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 06:42:09 INFO - Cleaning up... 06:42:09 INFO - Return code: 0 06:42:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:42:09 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')]} 06:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:09 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')]} 06:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:09 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:09 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 06:42:09 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 06:42:09 INFO - Using env: {'DISPLAY': ':0', 06:42:09 INFO - 'HOME': '/home/cltbld', 06:42:09 INFO - 'LANG': 'en_US.UTF-8', 06:42:09 INFO - 'LANGUAGE': 'en_US:en', 06:42:09 INFO - 'LOGNAME': 'cltbld', 06:42:09 INFO - 'MAIL': '/var/mail/cltbld', 06:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:09 INFO - 'MOZ_NO_REMOTE': '1', 06:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:09 INFO - 'NO_EM_RESTART': '1', 06:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:09 INFO - 'PWD': '/builds/slave/test', 06:42:09 INFO - 'SHELL': '/bin/bash', 06:42:09 INFO - 'SHLVL': '1', 06:42:09 INFO - 'TERM': 'linux', 06:42:09 INFO - 'TMOUT': '86400', 06:42:09 INFO - 'USER': 'cltbld', 06:42:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:09 INFO - '_': '/tools/buildbot/bin/python'} 06:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:09 INFO - Downloading/unpacking psutil>=3.1.1 06:42:09 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 06:42:09 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 06:42:09 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 06:42:09 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 06:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:10 INFO - Installing collected packages: psutil 06:42:10 INFO - Running setup.py install for psutil 06:42:10 INFO - building 'psutil._psutil_linux' extension 06:42:10 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 06:42:11 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 06:42:11 INFO - building 'psutil._psutil_posix' extension 06:42:11 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 06:42:11 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 06:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:11 INFO - Successfully installed psutil 06:42:11 INFO - Cleaning up... 06:42:11 INFO - Return code: 0 06:42:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:11 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:11 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 06:42:11 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 06:42:11 INFO - Using env: {'DISPLAY': ':0', 06:42:11 INFO - 'HOME': '/home/cltbld', 06:42:11 INFO - 'LANG': 'en_US.UTF-8', 06:42:11 INFO - 'LANGUAGE': 'en_US:en', 06:42:11 INFO - 'LOGNAME': 'cltbld', 06:42:11 INFO - 'MAIL': '/var/mail/cltbld', 06:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:11 INFO - 'MOZ_NO_REMOTE': '1', 06:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:11 INFO - 'NO_EM_RESTART': '1', 06:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:11 INFO - 'PWD': '/builds/slave/test', 06:42:11 INFO - 'SHELL': '/bin/bash', 06:42:11 INFO - 'SHLVL': '1', 06:42:11 INFO - 'TERM': 'linux', 06:42:11 INFO - 'TMOUT': '86400', 06:42:11 INFO - 'USER': 'cltbld', 06:42:11 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:11 INFO - '_': '/tools/buildbot/bin/python'} 06:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:42:11 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 06:42:11 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 06:42:11 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 06:42:11 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 06:42:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:42:12 INFO - Installing collected packages: mozsystemmonitor 06:42:12 INFO - Running setup.py install for mozsystemmonitor 06:42:12 INFO - Successfully installed mozsystemmonitor 06:42:12 INFO - Cleaning up... 06:42:12 INFO - Return code: 0 06:42:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42: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==2.5.1'] in /builds/slave/test/build 06:42: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==2.5.1 06:42:12 INFO - Using env: {'DISPLAY': ':0', 06:42:12 INFO - 'HOME': '/home/cltbld', 06:42:12 INFO - 'LANG': 'en_US.UTF-8', 06:42:12 INFO - 'LANGUAGE': 'en_US:en', 06:42:12 INFO - 'LOGNAME': 'cltbld', 06:42:12 INFO - 'MAIL': '/var/mail/cltbld', 06:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:12 INFO - 'MOZ_NO_REMOTE': '1', 06:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:12 INFO - 'NO_EM_RESTART': '1', 06:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:12 INFO - 'PWD': '/builds/slave/test', 06:42:12 INFO - 'SHELL': '/bin/bash', 06:42:12 INFO - 'SHLVL': '1', 06:42:12 INFO - 'TERM': 'linux', 06:42:12 INFO - 'TMOUT': '86400', 06:42:12 INFO - 'USER': 'cltbld', 06:42:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:12 INFO - '_': '/tools/buildbot/bin/python'} 06:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:13 INFO - Downloading/unpacking jsonschema==2.5.1 06:42:13 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 06:42:13 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 06:42:13 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 06:42:13 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 06:42:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:42:14 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 06:42:14 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 06:42:14 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 06:42:14 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 06:42:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:14 INFO - warning: no files found matching '*.txt' 06:42:14 INFO - no previously-included directories found matching 'build' 06:42:14 INFO - no previously-included directories found matching 'dist' 06:42:14 INFO - no previously-included directories found matching '.git*' 06:42:14 INFO - Installing collected packages: jsonschema, functools32 06:42:14 INFO - Running setup.py install for functools32 06:42:14 INFO - warning: no files found matching '*.txt' 06:42:14 INFO - no previously-included directories found matching 'build' 06:42:14 INFO - no previously-included directories found matching 'dist' 06:42:14 INFO - no previously-included directories found matching '.git*' 06:42:14 INFO - Successfully installed jsonschema functools32 06:42:14 INFO - Cleaning up... 06:42:14 INFO - Return code: 0 06:42:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:42:14 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')]} 06:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:14 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')]} 06:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:14 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:14 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 06:42:14 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 06:42:14 INFO - Using env: {'DISPLAY': ':0', 06:42:14 INFO - 'HOME': '/home/cltbld', 06:42:14 INFO - 'LANG': 'en_US.UTF-8', 06:42:14 INFO - 'LANGUAGE': 'en_US:en', 06:42:14 INFO - 'LOGNAME': 'cltbld', 06:42:14 INFO - 'MAIL': '/var/mail/cltbld', 06:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:14 INFO - 'MOZ_NO_REMOTE': '1', 06:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:14 INFO - 'NO_EM_RESTART': '1', 06:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:14 INFO - 'PWD': '/builds/slave/test', 06:42:14 INFO - 'SHELL': '/bin/bash', 06:42:14 INFO - 'SHLVL': '1', 06:42:14 INFO - 'TERM': 'linux', 06:42:14 INFO - 'TMOUT': '86400', 06:42:14 INFO - 'USER': 'cltbld', 06:42:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:14 INFO - '_': '/tools/buildbot/bin/python'} 06:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:42:14 INFO - Cleaning up... 06:42:14 INFO - Return code: 0 06:42:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:42:14 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')]} 06:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:14 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')]} 06:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:14 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:14 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 06:42:14 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 06:42:14 INFO - Using env: {'DISPLAY': ':0', 06:42:14 INFO - 'HOME': '/home/cltbld', 06:42:14 INFO - 'LANG': 'en_US.UTF-8', 06:42:14 INFO - 'LANGUAGE': 'en_US:en', 06:42:14 INFO - 'LOGNAME': 'cltbld', 06:42:14 INFO - 'MAIL': '/var/mail/cltbld', 06:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:14 INFO - 'MOZ_NO_REMOTE': '1', 06:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:14 INFO - 'NO_EM_RESTART': '1', 06:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:14 INFO - 'PWD': '/builds/slave/test', 06:42:14 INFO - 'SHELL': '/bin/bash', 06:42:14 INFO - 'SHLVL': '1', 06:42:14 INFO - 'TERM': 'linux', 06:42:14 INFO - 'TMOUT': '86400', 06:42:14 INFO - 'USER': 'cltbld', 06:42:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:14 INFO - '_': '/tools/buildbot/bin/python'} 06:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:14 INFO - Downloading/unpacking blobuploader==1.2.4 06:42:14 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 06:42:14 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 06:42:14 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 06:42:14 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 06:42:16 INFO - Downloading blobuploader-1.2.4.tar.gz 06:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:42:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:42:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:16 INFO - Downloading docopt-0.6.1.tar.gz 06:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:42:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:42:16 INFO - Running setup.py install for blobuploader 06:42:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:42:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:42:16 INFO - Running setup.py install for requests 06:42:17 INFO - Running setup.py install for docopt 06:42:17 INFO - Successfully installed blobuploader requests docopt 06:42:17 INFO - Cleaning up... 06:42:17 INFO - Return code: 0 06:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:17 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')]} 06:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:17 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')]} 06:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:17 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:17 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 06:42:17 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 06:42:17 INFO - Using env: {'DISPLAY': ':0', 06:42:17 INFO - 'HOME': '/home/cltbld', 06:42:17 INFO - 'LANG': 'en_US.UTF-8', 06:42:17 INFO - 'LANGUAGE': 'en_US:en', 06:42:17 INFO - 'LOGNAME': 'cltbld', 06:42:17 INFO - 'MAIL': '/var/mail/cltbld', 06:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:17 INFO - 'MOZ_NO_REMOTE': '1', 06:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:17 INFO - 'NO_EM_RESTART': '1', 06:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:17 INFO - 'PWD': '/builds/slave/test', 06:42:17 INFO - 'SHELL': '/bin/bash', 06:42:17 INFO - 'SHLVL': '1', 06:42:17 INFO - 'TERM': 'linux', 06:42:17 INFO - 'TMOUT': '86400', 06:42:17 INFO - 'USER': 'cltbld', 06:42:17 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:17 INFO - '_': '/tools/buildbot/bin/python'} 06:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:17 INFO - Running setup.py (path:/tmp/pip-4lt_tN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:17 INFO - Running setup.py (path:/tmp/pip-I8ifWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:17 INFO - Running setup.py (path:/tmp/pip-EJXTBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:17 INFO - Running setup.py (path:/tmp/pip-fsYvei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:17 INFO - Running setup.py (path:/tmp/pip-SF7R8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:17 INFO - Running setup.py (path:/tmp/pip-H2IHub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:17 INFO - Running setup.py (path:/tmp/pip-X_CsBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:17 INFO - Running setup.py (path:/tmp/pip-LxFYPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:17 INFO - Running setup.py (path:/tmp/pip-dUqlEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:18 INFO - Running setup.py (path:/tmp/pip-Rsn9_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:18 INFO - Running setup.py (path:/tmp/pip-9wrtJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:18 INFO - Running setup.py (path:/tmp/pip-058Apt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:18 INFO - Running setup.py (path:/tmp/pip-a6La6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:18 INFO - Running setup.py (path:/tmp/pip-RjqfwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:18 INFO - Running setup.py (path:/tmp/pip-olUQBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:18 INFO - Running setup.py (path:/tmp/pip-wR8t9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:18 INFO - Running setup.py (path:/tmp/pip-pZo6mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:42:18 INFO - Running setup.py install for manifestparser 06:42:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:42:18 INFO - Running setup.py install for mozcrash 06:42:18 INFO - Running setup.py install for mozdebug 06:42:18 INFO - Running setup.py install for mozdevice 06:42:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for mozfile 06:42:19 INFO - Running setup.py install for mozhttpd 06:42:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for mozinfo 06:42:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for mozInstall 06:42:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for mozleak 06:42:19 INFO - Running setup.py install for mozlog 06:42:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for moznetwork 06:42:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for mozprocess 06:42:19 INFO - Running setup.py install for mozprofile 06:42:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:42:19 INFO - Running setup.py install for mozrunner 06:42:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:42:20 INFO - Running setup.py install for mozscreenshot 06:42:20 INFO - Running setup.py install for moztest 06:42:20 INFO - Running setup.py install for mozversion 06:42:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:42:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:42:20 INFO - Cleaning up... 06:42:20 INFO - Return code: 0 06:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:20 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')]} 06:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:20 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')]} 06:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:20 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:20 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 06:42:20 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 06:42:20 INFO - Using env: {'DISPLAY': ':0', 06:42:20 INFO - 'HOME': '/home/cltbld', 06:42:20 INFO - 'LANG': 'en_US.UTF-8', 06:42:20 INFO - 'LANGUAGE': 'en_US:en', 06:42:20 INFO - 'LOGNAME': 'cltbld', 06:42:20 INFO - 'MAIL': '/var/mail/cltbld', 06:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:20 INFO - 'MOZ_NO_REMOTE': '1', 06:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:20 INFO - 'NO_EM_RESTART': '1', 06:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:20 INFO - 'PWD': '/builds/slave/test', 06:42:20 INFO - 'SHELL': '/bin/bash', 06:42:20 INFO - 'SHLVL': '1', 06:42:20 INFO - 'TERM': 'linux', 06:42:20 INFO - 'TMOUT': '86400', 06:42:20 INFO - 'USER': 'cltbld', 06:42:20 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:20 INFO - '_': '/tools/buildbot/bin/python'} 06:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:20 INFO - Running setup.py (path:/tmp/pip-MIz4uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:20 INFO - Running setup.py (path:/tmp/pip-FumcfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:20 INFO - Running setup.py (path:/tmp/pip-weXoWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:20 INFO - Running setup.py (path:/tmp/pip-wlbMpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:20 INFO - Running setup.py (path:/tmp/pip-0mAooB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:20 INFO - Running setup.py (path:/tmp/pip-l7jA55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:21 INFO - Running setup.py (path:/tmp/pip-vRxVZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:21 INFO - Running setup.py (path:/tmp/pip-h3PBCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:21 INFO - Running setup.py (path:/tmp/pip-DUMTBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:21 INFO - Running setup.py (path:/tmp/pip-sOpmgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:21 INFO - Running setup.py (path:/tmp/pip-qNhSdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:21 INFO - Running setup.py (path:/tmp/pip-YOFlPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:21 INFO - Running setup.py (path:/tmp/pip-Bd6kcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:21 INFO - Running setup.py (path:/tmp/pip-fRrYeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:21 INFO - Running setup.py (path:/tmp/pip-JkR8vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:21 INFO - Running setup.py (path:/tmp/pip-waGUM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:21 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)) 06:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:21 INFO - Running setup.py (path:/tmp/pip-nnTZp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:21 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)) 06:42:21 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)) 06:42:21 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)) 06:42:21 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)) 06:42:21 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:42:21 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:42:21 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 06:42:21 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 06:42:21 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 06:42:21 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 06:42:22 INFO - Downloading blessings-1.6.tar.gz 06:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:42:22 INFO - Installing collected packages: blessings 06:42:22 INFO - Running setup.py install for blessings 06:42:23 INFO - Successfully installed blessings 06:42:23 INFO - Cleaning up... 06:42:23 INFO - Return code: 0 06:42:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:23 INFO - Reading from file tmpfile_stdout 06:42:23 INFO - Current package versions: 06:42:23 INFO - argparse == 1.2.1 06:42:23 INFO - blessings == 1.6 06:42:23 INFO - blobuploader == 1.2.4 06:42:23 INFO - docopt == 0.6.1 06:42:23 INFO - functools32 == 3.2.3-2 06:42:23 INFO - jsonschema == 2.5.1 06:42:23 INFO - manifestparser == 1.1 06:42:23 INFO - mozInstall == 1.13 06:42:23 INFO - mozcrash == 1.0 06:42:23 INFO - mozdebug == 0.1 06:42:23 INFO - mozdevice == 0.51 06:42:23 INFO - mozfile == 1.2 06:42:23 INFO - mozhttpd == 0.7 06:42:23 INFO - mozinfo == 0.10 06:42:23 INFO - mozleak == 0.1 06:42:23 INFO - mozlog == 3.5 06:42:23 INFO - moznetwork == 0.27 06:42:23 INFO - mozprocess == 0.25 06:42:23 INFO - mozprofile == 0.28 06:42:23 INFO - mozrunner == 6.13 06:42:23 INFO - mozscreenshot == 0.1 06:42:23 INFO - mozsystemmonitor == 0.3 06:42:23 INFO - moztest == 0.8 06:42:23 INFO - mozversion == 1.4 06:42:23 INFO - psutil == 3.1.1 06:42:23 INFO - requests == 1.2.3 06:42:23 INFO - wsgiref == 0.1.2 06:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:23 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')]} 06:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:23 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')]} 06:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:23 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:23 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 06:42:23 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 06:42:23 INFO - Using env: {'DISPLAY': ':0', 06:42:23 INFO - 'HOME': '/home/cltbld', 06:42:23 INFO - 'LANG': 'en_US.UTF-8', 06:42:23 INFO - 'LANGUAGE': 'en_US:en', 06:42:23 INFO - 'LOGNAME': 'cltbld', 06:42:23 INFO - 'MAIL': '/var/mail/cltbld', 06:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:23 INFO - 'MOZ_NO_REMOTE': '1', 06:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:23 INFO - 'NO_EM_RESTART': '1', 06:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:23 INFO - 'PWD': '/builds/slave/test', 06:42:23 INFO - 'SHELL': '/bin/bash', 06:42:23 INFO - 'SHLVL': '1', 06:42:23 INFO - 'TERM': 'linux', 06:42:23 INFO - 'TMOUT': '86400', 06:42:23 INFO - 'USER': 'cltbld', 06:42:23 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:23 INFO - '_': '/tools/buildbot/bin/python'} 06:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 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)) 06:42:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:42:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:42:25 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)) 06:42:25 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)) 06:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:42:25 INFO - Installing collected packages: marionette-driver, simplejson 06:42:25 INFO - Running setup.py install for marionette-driver 06:42:25 INFO - Running setup.py install for simplejson 06:42:25 INFO - building 'simplejson._speedups' extension 06:42:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 06:42:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 06:42:26 INFO - Successfully installed marionette-driver simplejson 06:42:26 INFO - Cleaning up... 06:42:26 INFO - Return code: 0 06:42:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42:26 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')]} 06:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:26 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')]} 06:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:26 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 0x13461f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, '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': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', '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 06:42:26 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 06:42:26 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 06:42:26 INFO - Using env: {'DISPLAY': ':0', 06:42:26 INFO - 'HOME': '/home/cltbld', 06:42:26 INFO - 'LANG': 'en_US.UTF-8', 06:42:26 INFO - 'LANGUAGE': 'en_US:en', 06:42:26 INFO - 'LOGNAME': 'cltbld', 06:42:26 INFO - 'MAIL': '/var/mail/cltbld', 06:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:26 INFO - 'MOZ_NO_REMOTE': '1', 06:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:26 INFO - 'NO_EM_RESTART': '1', 06:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:26 INFO - 'PWD': '/builds/slave/test', 06:42:26 INFO - 'SHELL': '/bin/bash', 06:42:26 INFO - 'SHLVL': '1', 06:42:26 INFO - 'TERM': 'linux', 06:42:26 INFO - 'TMOUT': '86400', 06:42:26 INFO - 'USER': 'cltbld', 06:42:26 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:26 INFO - '_': '/tools/buildbot/bin/python'} 06:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:42:26 INFO - Cleaning up... 06:42:26 INFO - Return code: 0 06:42:26 INFO - Running post-action listener: _resource_record_post_action 06:42:26 INFO - Running post-action listener: _start_resource_monitoring 06:42:26 INFO - Starting resource monitoring. 06:42:26 INFO - [mozharness: 2017-07-27 13:42:26.726811Z] Finished create-virtualenv step (success) 06:42:26 INFO - [mozharness: 2017-07-27 13:42:26.727332Z] Running install step. 06:42:26 INFO - Running pre-action listener: _resource_record_pre_action 06:42:26 INFO - Running main action method: install 06:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:26 INFO - Reading from file tmpfile_stdout 06:42:26 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:27 INFO - Reading from file tmpfile_stdout 06:42:27 INFO - Output received: 06:42:27 INFO - Usage: mozinstall [options] installer 06:42:27 INFO - Options: 06:42:27 INFO - -h, --help show this help message and exit 06:42:27 INFO - -d DEST, --destination=DEST 06:42:27 INFO - Directory to install application into. [default: 06:42:27 INFO - "/builds/slave/test"] 06:42:27 INFO - --app=APP Application being installed. [default: firefox] 06:42:27 INFO - mkdir: /builds/slave/test/build/application 06:42:27 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'] 06:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:42:45 INFO - Reading from file tmpfile_stdout 06:42:45 INFO - Output received: 06:42:45 INFO - /builds/slave/test/build/application/firefox/firefox 06:42:45 INFO - Running post-action listener: _resource_record_post_action 06:42:45 INFO - [mozharness: 2017-07-27 13:42:45.090272Z] Finished install step (success) 06:42:45 INFO - [mozharness: 2017-07-27 13:42:45.090525Z] Running setup-mitmproxy step. 06:42:45 INFO - Running pre-action listener: _resource_record_pre_action 06:42:45 INFO - Running main action method: setup_mitmproxy 06:42:45 INFO - Skipping: mitmproxy is not required 06:42:45 INFO - Running post-action listener: _resource_record_post_action 06:42:45 INFO - [mozharness: 2017-07-27 13:42:45.091655Z] Finished setup-mitmproxy step (success) 06:42:45 INFO - [mozharness: 2017-07-27 13:42:45.091876Z] Running run-tests step. 06:42:45 INFO - Running pre-action listener: _resource_record_pre_action 06:42:45 INFO - Running pre-action listener: _set_gcov_prefix 06:42:45 INFO - Running main action method: run_tests 06:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:45 INFO - Python 2.7.3 06:42:45 INFO - Return code: 0 06:42:45 INFO - grabbing minidump binary from tooltool 06:42:45 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')]} 06:42:45 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 0x16b2eb0>, '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 0x16b3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16b4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:45 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 06:42:45 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 06:42:45 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 06:42:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:45 INFO - Return code: 0 06:42:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:42:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:45 INFO - ENV: RUST_BACKTRACE is now 1 06:42:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:42:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 06:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 06:42:45 INFO - Using env: {'DISPLAY': ':0', 06:42:45 INFO - 'HOME': '/home/cltbld', 06:42:45 INFO - 'LANG': 'en_US.UTF-8', 06:42:45 INFO - 'LANGUAGE': 'en_US:en', 06:42:45 INFO - 'LOGNAME': 'cltbld', 06:42:45 INFO - 'MAIL': '/var/mail/cltbld', 06:42:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:45 INFO - 'MOZ_NO_REMOTE': '1', 06:42:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:45 INFO - 'NO_EM_RESTART': '1', 06:42:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:45 INFO - 'PWD': '/builds/slave/test', 06:42:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:45 INFO - 'RUST_BACKTRACE': '1', 06:42:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:42:45 INFO - 'SHELL': '/bin/bash', 06:42:45 INFO - 'SHLVL': '1', 06:42:45 INFO - 'STYLO_FORCE_ENABLED': '1', 06:42:45 INFO - 'TERM': 'linux', 06:42:45 INFO - 'TMOUT': '86400', 06:42:45 INFO - 'USER': 'cltbld', 06:42:45 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442', 06:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:45 INFO - '_': '/tools/buildbot/bin/python'} 06:42:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 06:42:45 INFO - mozversion application_buildid: 20170727125647 06:42:45 INFO - mozversion application_changeset: 658cba6a971257e2ba39715ec938256dfc414776 06:42:45 INFO - mozversion application_display_name: Nightly 06:42:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:45 INFO - mozversion application_name: Firefox 06:42:45 INFO - mozversion application_remotingname: firefox 06:42:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:42:45 INFO - mozversion application_vendor: Mozilla 06:42:45 INFO - mozversion application_version: 56.0a1 06:42:45 INFO - mozversion platform_buildid: 20170727125647 06:42:45 INFO - mozversion platform_changeset: 658cba6a971257e2ba39715ec938256dfc414776 06:42:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:42:45 INFO - mozversion platform_version: 56.0a1 06:42:45 INFO - using testdate: 1501162965 06:42:45 INFO - actual date: 1501162965 06:42:45 INFO - starting webserver on 'localhost:39613' 06:42:45 INFO - SUITE-START | Running 2 tests 06:42:45 INFO - TEST-START | dromaeo_css 06:42:45 INFO - Initialising browser for dromaeo_css test... 06:42:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39613/getInfo.html -profile /tmp/tmpeG4QGH/profile 06:42:45 INFO - TEST-INFO | started process 4173 (/builds/slave/test/build/application/firefox/firefox http://localhost:39613/getInfo.html) 06:42:51 INFO - TEST-INFO | 4173: exit 0 06:42:51 INFO - Browser initialized. 06:42:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:51 INFO - TEST-INFO | started process 4400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeG4QGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:52 INFO - PID 4400 | 06:42:52 INFO - PID 4400 | (/builds/slave/test/build/application/firefox/firefox:4455): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:42:52 INFO - PID 4400 | 06:43:03 INFO - PID 4400 | RSS: Main: 171102208 06:43:03 INFO - PID 4400 | 06:46:02 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:39613/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39613/tests/dromaeo/cssquery-ext.html) 06:46:03 INFO - PID 4400 | RSS: Main: 175665152 06:46:03 INFO - PID 4400 | 06:49:05 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:39613/tests/dromaeo/cssquery-ext.html (next: http://localhost:39613/tests/dromaeo/cssquery-jquery.html) 06:49:05 INFO - PID 4400 | RSS: Main: 173121536 06:49:05 INFO - PID 4400 | 06:52:07 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:39613/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39613/tests/dromaeo/cssquery-mootools.html) 06:52:08 INFO - PID 4400 | RSS: Main: 174964736 06:52:08 INFO - PID 4400 | 06:55:10 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:39613/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39613/tests/dromaeo/cssquery-prototype.html) 06:55:10 INFO - PID 4400 | RSS: Main: 173211648 06:55:10 INFO - PID 4400 | 06:58:14 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:39613/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39613/tests/dromaeo/cssquery-yui.html) 06:58:15 INFO - PID 4400 | RSS: Main: 174309376 06:58:15 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | Cycle 1(1): loaded http://localhost:39613/tests/dromaeo/cssquery-yui.html (next: http://localhost:39613/tests/dromaeo/cssquery-dojo.html) 07:01:17 INFO - PID 4400 | RSS: Main: 176799744 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | __start_tp_report 07:01:17 INFO - PID 4400 | _x_x_mozilla_page_load 07:01:17 INFO - PID 4400 | _x_x_mozilla_page_load_details 07:01:17 INFO - PID 4400 | |i|pagename|runs| 07:01:17 INFO - PID 4400 | |0;dojo.html;3103.317270200555;3153.385089907469;3157.463231250687;3163.0827060152565;3178.2213357727346;6127.601705889119;6152.969235153823;6256.812295631138;6271.122042913996;6314.652694101834;6088.8477788055325;6210.7205175767085;6230.408111229437;6237.095621134933;6250.499960003201;5660.9716951415285;5690.260266165393;5690.772369105231;5719.914201286963;5731.684757338345;5726.055200891848;5750.137479378106;5755.82732518023;5756.539476841843;5766.7404966776385;5706.800261990831;5710.172025056364;5727.169560413738;5733.312002559699;5748.82753517393;5677.829665110033;5690.174924635946;5703.458171473703;5721.914171287434;5733.971330143323;5610.158476228557;5676.858078548028;5696.401877802812;5699.515541179005;5810.448007439287;6170.7223174957235;6171.6297022178815;6235.563510554263;6241.375862413768;6291.496680265568;6490.156279683658;6639.933600664028;6643;6730.2933192014625;6739.292374300677;6633.787643680996;6691.531592788507;6693.431058360045;6694.799156025327;6708.631025293607;5450.209719590677;6173.81478555644;6208.192934918477;6276.403741644536;6294.7482100715915;6836.794896153124;6842.7605033823575;6923.5499692519825;6926.688299026556;6931.341522555349;6385.840353991188;6493.22081350241;6497.9350206498275;6531.444827189742;6623.834404139839;6630.270670226271;6643.900341494881;6647.5346725729705;6652.467802575782;6660.433863121689;5950.821475355746;6558.901616475757;6593.340665933369;6593.637349945799;6632.668366581652;6597.439217666456;6619.172603424572;6702.731890724316;6729.293424190488;6747.325267473213;5317.335333083364;5322.707251101149;5399.406065332811;5406.91889621656;5413.9729301353245;4495.730256184639;4597.816087356468;4605.815767369335;4612.53874612536;4629.930551041737;5804.100364443518;5806.1000544915605;5806.912896306559;5806.941930580725;5811.970940145272;6613.537052406382;6652.667366631649;6701.463882889455;6708.127943367429;6709.7651582194385;5778.884422311614;5837.970810145922;5844.211031510777;5846.210761547221;5847.707614619337;5782.190493330937;5794.681292528951;5860.941390586125;5880.206172166788;5910.202122713465;6424.646644434601;6440.484761219185;6442.098106265126;6458.903116453257;6479.870402591921;6563.343665633399;6636.2368327642935;6653.800385988428;6667;6674.065630811593;6437.549371543947;6439.06633538125;6445.355464453704;6471.935280647133;6476.417122459001;5591.580631452576;6562.376574225441;6584.4732421405215;6584.8024559263295;6630.403263706289;6653.135092437952;6702.229243636849;6729.394354508117;6773.796786096425;6779.186497620317;6401.647909364843;6516.967415162894;6518.9569668852755;6522.445592124533;6554.737810487527;6462.483001359786;6471.611703297817;6473.676316184078;6478.963365861439;6488.351164883474;6406.295307516262;6414.61512309263;6432.2281326241155;6437.420632143129;6441.903371449338;6495.772647957298;6558.409743123142;6616.503762217949;6618.702158402787;6654.301298363602;6185.2886918003205;6301.180846489927;6304.9281622123435;6321.241451025906;6410.1987251593555 07:01:17 INFO - PID 4400 | |1;ext.html;790.0795573157272;825.3438516379479;851.1190917400492;852.6205838401912;1182.4678894497479;30697.539536906937;31152.68847311529;31224.531632025508;41347;42943.78528107363;42930.57069429305;43291.13417731643;43352.3497147543;43396.783016084955;43483.13033739323;7418.332350088491;7805.765827025199;8015.278624923756;8043;8056.8388632227325;7878.842423151534;7986;7986.1614530474335;7986.241307075818;7992.160823113548;7893.486923349992;7946.841063178733;7951.562664053475;7955.920440795605;7989.360851131924;7953.164917683618;8013.19868013194;8013.2387423194705;8016.759497215064;8017.158198389144;7853.096893857222;7902.604869756489;7907.327877130451;7909.169537198626;7913.327367173797;37878.81060594707;38016.23967520662;38074;38079.61920380789;38175;3468.0809585459874;3505.106197919514;3507.824608769551;3520.7359448041498;3533.8586456541707;31136.53295200574;31261.37477250465;31294.687053129634;31303.53044704331;31329.373412531848;4622.838200662961;4809.519048095198;4831.516848315176;4866.148424025781;4875.000624871893;178934;180317;180494;181020;181625;48094.75952620214;48099;48410.5158948406;48415.75792121017;48633.5136648629;50038.74980625074;50281.24578131331;50413.747931260106;50697.23954140691;50816.49183508191;14955;15138.697226055418;15163.620909477131;15171.848281517043;15200.391984320724;10871.402072886067;11142.665720028412;11152.275102118336;13622.93188534051;13900.235487048309;14014.71970560583;14038.578842634737;14072.155670659793;14346.784798228035;14355.78466323006;5618.943810561842;5864.179014937912;5920.940790592039;5951.732172052268;5967.283925928917;976.9706908792606;984.6061575369766;996.7159359582485;1012.3622118065572;1013.5742987945081;21955.463117581618;21958.780412195993;22609.434764131027;22918.08327666908;23033;1051.71603667011;1052.0689190066694;1073.6671631794168;1085.9837102443469;1088.8911108889206;11533.539938018728;11673.591424300279;11732.178747487595;11861;12165.296858439826;202345;204858;218619;219217;220138;51741.48258517442;52154;52154.47845521572;52159.217611735854;52383.73808130935;1480.6520467690084;1495.1178804505394;1505.2323315109372;1506.1716056169064;1510.2222355486933;21696.24063157782;21815.78184218201;21969.67045494351;22046.88976555107;22081.116755329607;37002;37059.81470092632;37138.25723485461;37210.25579488449;37229.62770372262;189911;190671;191313;191770;192234;30172.24569385783;31018.534721978736;34034.489482658275;34172.82913585416;34280.657193427745;38018.8099059514;42319;42400.36399453949;42537.14925701407;42589;29955.251118722208;30324.848375758862;30667.2333191672;30677;30815.691843081284;28511.572326414705;29666.25834354072;30088.398232035674;30203.395932081676;30489.54265686061;34405.655943440244;34471.138221544665;34544.30911381808;34860.65139348574;34978.825105874304;27589.58615620727;29568.704312957456;30134.849325753232;30452.543211852284;30453.695463045085;21873.453163671034;22209.333719988426;23751.287461376185;24702.25893223206;25030.74969250357 07:01:17 INFO - PID 4400 | |2;jquery.html;564.7317524176017;573.9783185929048;578.9797357092502;587.9323877754058;588.58210670424;21769.34691959242;22170.334889953327;22671.77328226717;22760.772392276092;22763.772362276373;24376.146834860785;25906.222813315584;25985.87007064962;26002;26082.608760868603;6546.9017964730565;6705.094812200364;6706.12820333356;6710.42961348286;6719.8656026879435;6352.777652782153;6407.070974708665;6482.157319548475;6489.22129344477;6489.480841532666;6054.485368743662;6426.325235850239;6439.549231553793;6499.155109835715;6499.577527460724;6326.082718005863;6460.870782584346;6480.384363485485;6487.156669632965;6492.772752953648;5937.554683398763;5958.821235362946;5964.284285885721;5971.820845374646;5976.312724036705;27607.447851043067;28508.287292817844;28782;28971.275718107005;29975.250618734488;1909.30310436691;1963.4796778853472;1963.9018049097488;1965.0764140853776;1969.4091772468203;18467.538311542183;18793.90603046976;18946.715799263024;18953;18956.146973386094;2260.9321720348416;2287.0737351372554;2329.813614910803;2330.731965823935;2350.048230466664;128209;131987;132265.33867330698;132704;133422.33288833592;13971.510997115052;14745.705085898222;14873.033252838532;14920.104793712411;14995.2502374883;23295.53408931812;23298.53402931932;23432;23451.530969380517;23499.17752878641;9888.456134912649;9911.405315681082;10073.345232559861;10079.848802267972;10108.39349639024;9136.862947055799;9194.609401555645;9238.95380523093;9325.114114159143;9371.344005919656;8374.246317831425;8807.515586642668;9089.5000774958;9237.584308706124;9345.719628411158;2590.805689573252;2591.3651155467032;2684.7181045990283;2759.406727553586;2842.6873043965147;915.4095608332589;924.3529529329496;962.3696478806393;971.9951400242953;978.5254151736402;18821.90589047046;18941.43175704731;19119.044047797834;19122.33071842479;19527.218911243675;966.9564869580745;1023.7287118913493;1032.7521394865328;1039.859618951447;1043.5147656339839;10475.214358923111;10528;10571.682849514373;10622.203334749925;11083.445827708581;476115;480434;487684;506481;512810;119681;121255;124962;125063.374683126;126540;1240.9503619855286;1279.32195936154;1295.2746461981321;1303.6610481275127;1307.5488956310248;16090.015468289725;17068.146592670564;17237;17523.474295771146;19905.60188796245;54123.458765411844;55175.724121379135;55235;55934.16098758441;56398.718006409705;64005;64392.356076438635;64927.67536162289;64996;65339;12201.877981220074;14608.488702895347;14938.402463901322;14966.700665986837;15007.324670390077;17379.739303910705;19257.13342899601;19321.130549125042;19541;24660.383490412165;18823;18841.717374239124;19092.522686932938;19215;19238.326658566883;15252.923735381251;15436.922815385851;16087.276072576997;17040.659186816443;17584.91207543954;19222.7116593254;19425.708614370513;19879.204831806564;19949.401517954484;19960.101795418952;14535.27323633793;14558.927205363905;14639.92680036593;14648;14678.559643210721;19028;19070.14184361679;19291.93894335825;19423.90288048607;19655.410337689893 07:01:17 INFO - PID 4400 | |3;mootools.html;1327.2898999035515;1342.087380581205;1369.9863001369986;1376.0780277214265;1383.3774801339393;13036.804447933277;13498.460061597536;13565.389557469913;13581.185128892273;13731.17612943224;13596.456141754343;13744.381502832372;13766.587002389919;13800.309984500786;13806.378712957916;2621.1481268587736;2689.072270066824;2694.434168824549;2694.595810628402;2694.892204311825;2191.3864118046895;2290.5991451496006;2484.167803785734;2506.774390304872;2594.1439325022698;2550.9489810203786;2560.6927168739776;2561.2700380391593;2562.551553478143;2564.833285836424;2492.887820048102;2547.923562293125;2566.5765148750434;2572.601246806748;2577.1624222127884;2519.8362106463023;2545.669063021814;2559.078731656602;2561.5005074010573;2562.2569454858067;13764.380602872894;13808.447662093504;13919.443222271097;13929.442822287096;13937.372818223204;7544.4718869679145;7848.646810893466;7849.725259615943;7855.253750893656;7862.960685196595;4635.281531362644;4787.904241915177;4814.831480898151;4982.950170498285;5023.2214006829;1826.4520643806939;1839.0804597701149;1882.9623407531772;1902.5909429472729;1908.2748555548803;21059.473513162142;21148;21185.576288474145;21274.574508509897;21362;6360.459360954278;6458.580192287486;6502.577332473374;6611.404973552403;6631;14902.850971490363;14907.627309317353;14913.403463861325;14919.328630211667;14923.403063877324;7346.706131754777;7533.359664428475;7540.9622951884885;7541.924580754122;7549.7357592483995;6742.797716068526;6856.828579285458;6939.514234003672;6975.441964642816;7119.6084215368655;5069.771860266297;5177.58579313654;5218.869528261824;5220.295260139908;5228.2941802856885;1435.1245740098532;1464.6777708904024;1507.487454265555;1528.2969833876318;1547.7910482085;815.8980127484065;824.6660102658433;826.1325608111459;832.5046597274612;852.6418904060309;6260.40526150015;6557;7835.138134805167;8041.195880411912;8123.228293312126;889.3996552327153;907.514479753342;927.3647551427159;959.4627008875052;971.8153550825461;4550.453945526492;4613.746243956548;4617.445906491175;4733.148033354029;4774.761261936958;17930;18887.81112188888;18894.05529723508;18904.716429253298;18930.621387572446;17815.821841781417;18967.146478408504;19012.144453499626;19049.523761906064;19086.427407177805;10817.621383251548;10896.727581810519;10946.507407166697;10974.122070234362;11039.558417663364;7145;7636.694532218649;7738.651760670896;7824.374050076094;7859.921400786147;16044.43844465438;16383.836161638708;16703;17024.319027238773;17041.573960651083;15995;16300.347986080424;16918.154092295088;17068;17147.228374723418;11407.657770266906;11585;11638.301701897575;11646.70883227926;11648.88351116478;12750.68123296925;12792.296423696785;13082.476700931857;13205.537806176737;13233.602991910258;9576.281778866474;10269.537870795682;10461.9476902615;10484.842727358942;10604.257701960789;9725.173360264456;10109.898901011189;10138.290319677551;10390.22073344487;10398.27212095146;8574.31405487572;8663.870041949502;8665.696700615448;8668.956655216683;8674.219320261207;6337.334579869232;6588.275289718032;6639.402453779183;6687.130673012477;6764.3573860483175;6613.5701179425105;6658.966705166443;6679.131712877295;6716;6752.831179220559 07:01:17 INFO - PID 4400 | |4;prototype.html;494.0653111036749;497.44396382225705;517.3145582103714;520.4925197932016;525.1545012529826;6226.567889385438;6231.657258850767;6256.655883926388;6293.465055470279;6319.336469670688;5848.532117430606;6011.54913381497;6056.333803281646;6127.877442451148;6162.815115546529;4950.4307004694565;4961.3798275215595;4970.452036386702;4980.77586508608;4986.675866068694;4930.3344048553345;4942.258661200813;4957.801687932497;4976.203807390818;5009.49905009498;4764.809407623691;4894.77973491192;4899.510048995107;4928.433230178522;4938.777755001033;4905.583025442842;4918.754062296871;4922.384701912261;4956.578690811285;4961;4423.093265880487;4426.712263702849;4435.1573201092015;4438.334249862514;4447;6064.939350606482;6085.2697676278685;6088.604240724383;6098.54260930432;6104.389561043905;5718.5711071669375;5728.427157284238;5735.340435849847;5737.913931291034;5763.596548241625;6551.082848401227;6560.901586476207;6570.901436478457;6575.441087507567;6621.404073633396;4833.854984350475;4840.273958906157;4846.806127754886;4875.293082503053;4882.707037577757;6868.519203655746;6960.617166055865;6971.233164351917;6986.650667466657;6994.300569942965;4968.354113965162;4969.90060198794;4972.5027497249985;4990.675606085665;5037.19404895215;5059.56993655536;5067.5185857343495;5075.264086707407;5079.619028572798;5091.770870310771;5678;5685.573581981368;5700.144978253295;5710.343310519261;5735.369109397963;6502.536929190989;6550.7707230246715;6572.079908812674;6588.275289718127;6630.867382652416;1618.4335482581002;1684.292597109217;1687.4768821665077;1713.083500327319;1720.1657196259805;1183.6981569699844;1205.878532964334;1217.3061355027548;1221.8594861590852;1225.7609766095704;5683.687397193194;5718.857028574235;5739.225204597409;5740.138979153077;5767;6438;6557.967030220551;6672.532922695462;6714.328567143344;6730.596164230162;5692.117721753135;5726.1410788381245;5744.224529688438;5746.2529871116485;5834.978878696211;3544.80503572306;3549.5917969433845;3560.501529785832;3561.7765921840773;3577.964220357815;6529.575577587441;6566.868662626721;6570.047343135218;6600.80197594073;6632.9336706633285;6836.026328546998;6882;6958.37374636275;6962.582245065312;6982.895256571155;6410.551261411843;6523.151990241238;6550.6069635822005;6596.175478065242;6619;6651.405951678752;6688.4983626229205;6699.598024118569;6715.485978600749;6742.5280230383405;6565.704543295658;6608.669566521751;6688.83277918056;6703.3296670332575;6709.698063587052;6461.224653041665;6573.671316434255;6599.175103112111;6610.537262391779;6631.933680663132;5515.227868098389;5518.172274158908;5563.916541251965;5570.470805273492;5582.944170558405;6780.288069752803;6803.93196068033;6811.489138314745;6836.965815170893;6843.794686159423;6548.410643042149;6591.5056370773345;6611.570247933869;6611.768588099393;6623.138991931018;6284.497240220863;6591.901121483277;6593.571417857824;6634.601923884389;6649.900251496135;6153.261608606996;6245.156903817927;6336.827686877942;6398.648074355769;6437.452816510649;6388.233411990591;6411.069760471639;6457.128287681103;6462.931861804178;6587.374199451045;6119.908201376894;6159.19930409044;6197.96901015492;6202.844928876814;6231.594946328474 07:01:17 INFO - PID 4400 | |5;yui.html;866.7183165471223;887;899.5547204133952;902.2376092202092;908.9728606674465;16691.666166676674;17166.055866927312;17320.307187712493;17331.91334043328;20719.274825381115;16094.436694715687;17140.14299285037;17150.828491715078;17182.914085429587;17197.570060748487;1004.7387679203423;1010.7826817234293;1012.266107072374;1012.792377562598;1015.3958394755109;969.3602222533129;993.2997236947934;1039.4542864995863;1042.0569384706853;1045.5556388534842;1100.5707773968159;1109.4619109731773;1112.0158659586284;1112.0491979357614;1112.3937454087502;1094.031781873048;1101.9944900275486;1102.0412241349998;1103.5751235774205;1104.2325583719319;800.2597597222604;805.8912046873714;809.951402915827;809.9878501822418;813.2924355810483;18258.543536411562;19071.90464047671;19092.71360929587;19141.712874306897;19271.51821204481;20276.594468110554;20346.898265508727;20566.97165141737;20822;20895.37313880586;15542.689146217012;15575.143367114804;15716.135612541306;15738.370465181379;15922.681546369007;3461.567304086989;3531.94702079469;3546.7517273790845;3548.538689970313;3549.4143466328023;115915.42042289818;117710;118034;123267;124498;15929.362825487082;16295;16295.185240737916;16303.103329317002;16316.836831631768;29963.700362996093;29992.400151996837;30035.69964300373;30045;30068.24829379283;8414.663413463515;8424.578771061422;8462.238398544161;8547.230749232598;8578.914210857936;4043.7169398142437;4136.400221967798;4142.896427589334;4151.4395556599475;4155.397467367276;4905.901881962341;4905.950940490621;5112.795488180431;5688.914666280009;5861.794837180763;999.5352161245056;1024.3956065921143;1029.3463650581934;1034.622362837559;1035.8446233065101;640.4172203294979;645.3772109913956;679.188369897977;679.755288096285;688.944884409246;11058.612948546923;13329.733405332034;13657.795133073012;13741.381637826322;13811.792823107662;642.958207716497;655.0763423572739;663.5554178700282;674.8279188806823;675.9628220447825;4959.231319145538;5275.96631936638;5306.655067420683;5414.996451313039;5429.891402171935;99175.50412247893;102044.48977755064;102462.48768756108;102662;104272.47863760633;84371;85104;85587.57206214053;88066;90635.54682226546;74823.62588187025;77158.61420692973;78983;81321.59339203384;81491.18508814955;11639.185257031926;12280.508779649072;12489.313087779896;12760.6809829755;12790.232586044867;32980.340393192484;34096;35078.12304692403;35293.82353088218;37400.812995935936;45130.54869451263;45219.773901130284;46349;47224.52775472201;65409.0565924525;17301.913490432467;17684.823151768316;17936.372226971995;18060.458186254433;18262;20797.272095476586;20920.47698807542;21144.682829757257;21385.25151619686;21424.892875535523;17953.829707318702;18805.90597047006;18911.90544047326;18970.905145474186;19092.33176838804;19413.223471061;19531.70702439436;19537.413877583695;19555.60888782188;19734.60530789405;17734.73397899007;18543.53641158982;18811.435656929767;19017.904910475358;19431.514212144808;12606.49574017029;12673.366331683195;12695.746085078432;12834.55079072228;13389.866101339252;14104.294785260901;14196.361163747863;14370.425182992563;14374.281285935871;14452.2051287176 07:01:17 INFO - PID 4400 | __end_tp_report 07:01:17 INFO - PID 4400 | __start_cc_report 07:01:17 INFO - PID 4400 | _x_x_mozilla_cycle_collect,352 07:01:17 INFO - PID 4400 | __end_cc_report 07:01:17 INFO - PID 4400 | __startTimestamp1501164077623__endTimestamp 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | ------- Summary: start ------- 07:01:17 INFO - PID 4400 | Number of tests: 6 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | [#0] dojo.html Cycles:165 Average:6123.17 Median:6401.65 stddev:722.68 (11.3%) stddev-sans-first:684.97 07:01:17 INFO - PID 4400 | Values: 3103.3 3153.4 3157.5 3163.1 3178.2 6127.6 6153.0 6256.8 6271.1 6314.7 6088.8 6210.7 6230.4 6237.1 6250.5 5661.0 5690.3 5690.8 5719.9 5731.7 5726.1 5750.1 5755.8 5756.5 5766.7 5706.8 5710.2 5727.2 5733.3 5748.8 5677.8 5690.2 5703.5 5721.9 5734.0 5610.2 5676.9 5696.4 5699.5 5810.4 6170.7 6171.6 6235.6 6241.4 6291.5 6490.2 6639.9 6643.0 6730.3 6739.3 6633.8 6691.5 6693.4 6694.8 6708.6 5450.2 6173.8 6208.2 6276.4 6294.7 6836.8 6842.8 6923.5 6926.7 6931.3 6385.8 6493.2 6497.9 6531.4 6623.8 6630.3 6643.9 6647.5 6652.5 6660.4 5950.8 6558.9 6593.3 6593.6 6632.7 6597.4 6619.2 6702.7 6729.3 6747.3 5317.3 5322.7 5399.4 5406.9 5414.0 4495.7 4597.8 4605.8 4612.5 4629.9 5804.1 5806.1 5806.9 5806.9 5812.0 6613.5 6652.7 6701.5 6708.1 6709.8 5778.9 5838.0 5844.2 5846.2 5847.7 5782.2 5794.7 5860.9 5880.2 5910.2 6424.6 6440.5 6442.1 6458.9 6479.9 6563.3 6636.2 6653.8 6667.0 6674.1 6437.5 6439.1 6445.4 6471.9 6476.4 5591.6 6562.4 6584.5 6584.8 6630.4 6653.1 6702.2 6729.4 6773.8 6779.2 6401.6 6517.0 6519.0 6522.4 6554.7 6462.5 6471.6 6473.7 6479.0 6488.4 6406.3 6414.6 6432.2 6437.4 6441.9 6495.8 6558.4 6616.5 6618.7 6654.3 6185.3 6301.2 6304.9 6321.2 6410.2 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | [#1] ext.html Cycles:180 Average:36087.44 Median:34343.16 stddev:50583.65 (147.3%) stddev-sans-first:50656.11 07:01:17 INFO - PID 4400 | Values: 790.1 825.3 851.1 852.6 1182.5 30697.5 31152.7 31224.5 41347.0 42943.8 42930.6 43291.1 43352.3 43396.8 43483.1 7418.3 7805.8 8015.3 8043.0 8056.8 7878.8 7986.0 7986.2 7986.2 7992.2 7893.5 7946.8 7951.6 7955.9 7989.4 7953.2 8013.2 8013.2 8016.8 8017.2 7853.1 7902.6 7907.3 7909.2 7913.3 37878.8 38016.2 38074.0 38079.6 38175.0 3468.1 3505.1 3507.8 3520.7 3533.9 31136.5 31261.4 31294.7 31303.5 31329.4 4622.8 4809.5 4831.5 4866.1 4875.0 178934.0 180317.0 180494.0 181020.0 181625.0 48094.8 48099.0 48410.5 48415.8 48633.5 50038.7 50281.2 50413.7 50697.2 50816.5 14955.0 15138.7 15163.6 15171.8 15200.4 10871.4 11142.7 11152.3 13622.9 13900.2 14014.7 14038.6 14072.2 14346.8 14355.8 5618.9 5864.2 5920.9 5951.7 5967.3 977.0 984.6 996.7 1012.4 1013.6 21955.5 21958.8 22609.4 22918.1 23033.0 1051.7 1052.1 1073.7 1086.0 1088.9 11533.5 11673.6 11732.2 11861.0 12165.3 202345.0 204858.0 218619.0 219217.0 220138.0 51741.5 52154.0 52154.5 52159.2 52383.7 1480.7 1495.1 1505.2 1506.2 1510.2 21696.2 21815.8 21969.7 22046.9 22081.1 37002.0 37059.8 37138.3 37210.3 37229.6 189911.0 190671.0 191313.0 191770.0 192234.0 30172.2 31018.5 34034.5 34172.8 34280.7 38018.8 42319.0 42400.4 42537.1 42589.0 29955.3 30324.8 30667.2 30677.0 30815.7 28511.6 29666.3 30088.4 30203.4 30489.5 34405.7 34471.1 34544.3 34860.7 34978.8 27589.6 29568.7 30134.8 30452.5 30453.7 21873.5 22209.3 23751.3 24702.3 25030.7 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | [#2] jquery.html Cycles:180 Average:34538.44 Median:22762.27 stddev:82978.13 (364.5%) stddev-sans-first:83171.70 07:01:17 INFO - PID 4400 | Values: 564.7 574.0 579.0 587.9 588.6 21769.3 22170.3 22671.8 22760.8 22763.8 24376.1 25906.2 25985.9 26002.0 26082.6 6546.9 6705.1 6706.1 6710.4 6719.9 6352.8 6407.1 6482.2 6489.2 6489.5 6054.5 6426.3 6439.5 6499.2 6499.6 6326.1 6460.9 6480.4 6487.2 6492.8 5937.6 5958.8 5964.3 5971.8 5976.3 27607.4 28508.3 28782.0 28971.3 29975.3 1909.3 1963.5 1963.9 1965.1 1969.4 18467.5 18793.9 18946.7 18953.0 18956.1 2260.9 2287.1 2329.8 2330.7 2350.0 128209.0 131987.0 132265.3 132704.0 133422.3 13971.5 14745.7 14873.0 14920.1 14995.3 23295.5 23298.5 23432.0 23451.5 23499.2 9888.5 9911.4 10073.3 10079.8 10108.4 9136.9 9194.6 9239.0 9325.1 9371.3 8374.2 8807.5 9089.5 9237.6 9345.7 2590.8 2591.4 2684.7 2759.4 2842.7 915.4 924.4 962.4 972.0 978.5 18821.9 18941.4 19119.0 19122.3 19527.2 967.0 1023.7 1032.8 1039.9 1043.5 10475.2 10528.0 10571.7 10622.2 11083.4 476115.0 480434.0 487684.0 506481.0 512810.0 119681.0 121255.0 124962.0 125063.4 126540.0 1241.0 1279.3 1295.3 1303.7 1307.5 16090.0 17068.1 17237.0 17523.5 19905.6 54123.5 55175.7 55235.0 55934.2 56398.7 64005.0 64392.4 64927.7 64996.0 65339.0 12201.9 14608.5 14938.4 14966.7 15007.3 17379.7 19257.1 19321.1 19541.0 24660.4 18823.0 18841.7 19092.5 19215.0 19238.3 15252.9 15436.9 16087.3 17040.7 17584.9 19222.7 19425.7 19879.2 19949.4 19960.1 14535.3 14558.9 14639.9 14648.0 14678.6 19028.0 19070.1 19291.9 19423.9 19655.4 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | [#3] mootools.html Cycles:180 Average:8433.63 Median:2549.44 stddev:5700.94 (223.6%) stddev-sans-first:5691.93 07:01:17 INFO - PID 4400 | Values: 1327.3 1342.1 1370.0 1376.1 1383.4 13036.8 13498.5 13565.4 13581.2 13731.2 13596.5 13744.4 13766.6 13800.3 13806.4 2621.1 2689.1 2694.4 2694.6 2694.9 2191.4 2290.6 2484.2 2506.8 2594.1 2550.9 2560.7 2561.3 2562.6 2564.8 2492.9 2547.9 2566.6 2572.6 2577.2 2519.8 2545.7 2559.1 2561.5 2562.3 13764.4 13808.4 13919.4 13929.4 13937.4 7544.5 7848.6 7849.7 7855.3 7863.0 4635.3 4787.9 4814.8 4983.0 5023.2 1826.5 1839.1 1883.0 1902.6 1908.3 21059.5 21148.0 21185.6 21274.6 21362.0 6360.5 6458.6 6502.6 6611.4 6631.0 14902.9 14907.6 14913.4 14919.3 14923.4 7346.7 7533.4 7541.0 7541.9 7549.7 6742.8 6856.8 6939.5 6975.4 7119.6 5069.8 5177.6 5218.9 5220.3 5228.3 1435.1 1464.7 1507.5 1528.3 1547.8 815.9 824.7 826.1 832.5 852.6 6260.4 6557.0 7835.1 8041.2 8123.2 889.4 907.5 927.4 959.5 971.8 4550.5 4613.7 4617.4 4733.1 4774.8 17930.0 18887.8 18894.1 18904.7 18930.6 17815.8 18967.1 19012.1 19049.5 19086.4 10817.6 10896.7 10946.5 10974.1 11039.6 7145.0 7636.7 7738.7 7824.4 7859.9 16044.4 16383.8 16703.0 17024.3 17041.6 15995.0 16300.3 16918.2 17068.0 17147.2 11407.7 11585.0 11638.3 11646.7 11648.9 12750.7 12792.3 13082.5 13205.5 13233.6 9576.3 10269.5 10461.9 10484.8 10604.3 9725.2 10109.9 10138.3 10390.2 10398.3 8574.3 8663.9 8665.7 8669.0 8674.2 6337.3 6588.3 6639.4 6687.1 6764.4 6613.6 6659.0 6679.1 6716.0 6752.8 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | [#4] prototype.html Cycles:180 Average:5515.31 Median:6093.57 stddev:1553.35 (25.5%) stddev-sans-first:1511.30 07:01:17 INFO - PID 4400 | Values: 494.1 497.4 517.3 520.5 525.2 6226.6 6231.7 6256.7 6293.5 6319.3 5848.5 6011.5 6056.3 6127.9 6162.8 4950.4 4961.4 4970.5 4980.8 4986.7 4930.3 4942.3 4957.8 4976.2 5009.5 4764.8 4894.8 4899.5 4928.4 4938.8 4905.6 4918.8 4922.4 4956.6 4961.0 4423.1 4426.7 4435.2 4438.3 4447.0 6064.9 6085.3 6088.6 6098.5 6104.4 5718.6 5728.4 5735.3 5737.9 5763.6 6551.1 6560.9 6570.9 6575.4 6621.4 4833.9 4840.3 4846.8 4875.3 4882.7 6868.5 6960.6 6971.2 6986.7 6994.3 4968.4 4969.9 4972.5 4990.7 5037.2 5059.6 5067.5 5075.3 5079.6 5091.8 5678.0 5685.6 5700.1 5710.3 5735.4 6502.5 6550.8 6572.1 6588.3 6630.9 1618.4 1684.3 1687.5 1713.1 1720.2 1183.7 1205.9 1217.3 1221.9 1225.8 5683.7 5718.9 5739.2 5740.1 5767.0 6438.0 6558.0 6672.5 6714.3 6730.6 5692.1 5726.1 5744.2 5746.3 5835.0 3544.8 3549.6 3560.5 3561.8 3578.0 6529.6 6566.9 6570.0 6600.8 6632.9 6836.0 6882.0 6958.4 6962.6 6982.9 6410.6 6523.2 6550.6 6596.2 6619.0 6651.4 6688.5 6699.6 6715.5 6742.5 6565.7 6608.7 6688.8 6703.3 6709.7 6461.2 6573.7 6599.2 6610.5 6631.9 5515.2 5518.2 5563.9 5570.5 5582.9 6780.3 6803.9 6811.5 6837.0 6843.8 6548.4 6591.5 6611.6 6611.8 6623.1 6284.5 6591.9 6593.6 6634.6 6649.9 6153.3 6245.2 6336.8 6398.6 6437.5 6388.2 6411.1 6457.1 6462.9 6587.4 6119.9 6159.2 6198.0 6202.8 6231.6 07:01:17 INFO - PID 4400 | 07:01:17 INFO - PID 4400 | [#5] yui.html Cycles:180 Average:22008.31 Median:19481.61 stddev:29143.18 (149.6%) stddev-sans-first:29181.70 07:01:17 INFO - PID 4400 | Values: 866.7 887.0 899.6 902.2 909.0 16691.7 17166.1 17320.3 17331.9 20719.3 16094.4 17140.1 17150.8 17182.9 17197.6 1004.7 1010.8 1012.3 1012.8 1015.4 969.4 993.3 1039.5 1042.1 1045.6 1100.6 1109.5 1112.0 1112.0 1112.4 1094.0 1102.0 1102.0 1103.6 1104.2 800.3 805.9 810.0 810.0 813.3 18258.5 19071.9 19092.7 19141.7 19271.5 20276.6 20346.9 20567.0 20822.0 20895.4 15542.7 15575.1 15716.1 15738.4 15922.7 3461.6 3531.9 3546.8 3548.5 3549.4 115915.4 117710.0 118034.0 123267.0 124498.0 15929.4 16295.0 16295.2 16303.1 16316.8 29963.7 29992.4 30035.7 30045.0 30068.2 8414.7 8424.6 8462.2 8547.2 8578.9 4043.7 4136.4 4142.9 4151.4 4155.4 4905.9 4906.0 5112.8 5688.9 5861.8 999.5 1024.4 1029.3 1034.6 1035.8 640.4 645.4 679.2 679.8 688.9 11058.6 13329.7 13657.8 13741.4 13811.8 643.0 655.1 663.6 674.8 676.0 4959.2 5276.0 5306.7 5415.0 5429.9 99175.5 102044.5 102462.5 102662.0 104272.5 84371.0 85104.0 85587.6 88066.0 90635.5 74823.6 77158.6 78983.0 81321.6 81491.2 11639.2 12280.5 12489.3 12760.7 12790.2 32980.3 34096.0 35078.1 35293.8 37400.8 45130.5 45219.8 46349.0 47224.5 65409.1 17301.9 17684.8 17936.4 18060.5 18262.0 20797.3 20920.5 21144.7 21385.3 21424.9 17953.8 18805.9 18911.9 18970.9 19092.3 19413.2 19531.7 19537.4 19555.6 19734.6 17734.7 18543.5 18811.4 19017.9 19431.5 12606.5 12673.4 12695.7 12834.6 13389.9 14104.3 14196.4 14370.4 14374.3 14452.2 07:01:17 INFO - PID 4400 | -------- Summary: end -------- 07:01:17 INFO - PID 4400 | 07:01:18 INFO - TEST-INFO | 4400: exit 0 07:01:18 INFO - TEST-OK | dromaeo_css | took 1112915ms 07:01:18 INFO - TEST-START | kraken 07:01:18 INFO - Initialising browser for kraken test... 07:01:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39613/getInfo.html -profile /tmp/tmpxPb5FL/profile 07:01:18 INFO - TEST-INFO | started process 4774 (/builds/slave/test/build/application/firefox/firefox http://localhost:39613/getInfo.html) 07:01:24 INFO - TEST-INFO | 4774: exit 0 07:01:24 INFO - Browser initialized. 07:01:24 INFO - Running cycle 1/1 for kraken test... 07:01:24 INFO - TEST-INFO | started process 5002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxPb5FL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:25 INFO - PID 5002 | 07:01:25 INFO - PID 5002 | (/builds/slave/test/build/application/firefox/firefox:5056): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:01:25 INFO - PID 5002 | 07:01:35 INFO - PID 5002 | RSS: Main: 173551616 07:01:35 INFO - PID 5002 | 07:01:38 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39613/tests/kraken/driver.html?testName=audio-beat-detection) 07:01:39 INFO - PID 5002 | RSS: Main: 178475008 07:01:39 INFO - PID 5002 | 07:01:42 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39613/tests/kraken/driver.html?testName=audio-dft) 07:01:43 INFO - PID 5002 | RSS: Main: 178769920 07:01:43 INFO - PID 5002 | 07:01:46 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39613/tests/kraken/driver.html?testName=audio-fft) 07:01:46 INFO - PID 5002 | RSS: Main: 174026752 07:01:46 INFO - PID 5002 | 07:01:49 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39613/tests/kraken/driver.html?testName=audio-oscillator) 07:01:49 INFO - PID 5002 | RSS: Main: 174157824 07:01:49 INFO - PID 5002 | 07:01:51 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39613/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:52 INFO - PID 5002 | RSS: Main: 174927872 07:01:52 INFO - PID 5002 | 07:01:55 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39613/tests/kraken/driver.html?testName=imaging-darkroom) 07:01:56 INFO - PID 5002 | RSS: Main: 177111040 07:01:56 INFO - PID 5002 | 07:01:59 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39613/tests/kraken/driver.html?testName=imaging-desaturate) 07:02:00 INFO - PID 5002 | RSS: Main: 176398336 07:02:00 INFO - PID 5002 | 07:02:03 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39613/tests/kraken/driver.html?testName=json-parse-financial) 07:02:04 INFO - PID 5002 | RSS: Main: 177606656 07:02:04 INFO - PID 5002 | 07:02:05 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39613/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:02:06 INFO - PID 5002 | RSS: Main: 177508352 07:02:06 INFO - PID 5002 | 07:02:08 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:02:08 INFO - PID 5002 | RSS: Main: 174616576 07:02:08 INFO - PID 5002 | 07:02:11 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:02:11 INFO - PID 5002 | RSS: Main: 174366720 07:02:11 INFO - PID 5002 | 07:02:14 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:02:15 INFO - PID 5002 | RSS: Main: 175501312 07:02:15 INFO - PID 5002 | 07:02:18 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:02:19 INFO - PID 5002 | RSS: Main: 174989312 07:02:19 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | Cycle 1(1): loaded http://localhost:39613/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39613/tests/kraken/driver.html?testName=ai-astar) 07:02:21 INFO - PID 5002 | RSS: Main: 176869376 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | __start_tp_report 07:02:21 INFO - PID 5002 | _x_x_mozilla_page_load 07:02:21 INFO - PID 5002 | _x_x_mozilla_page_load_details 07:02:21 INFO - PID 5002 | |i|pagename|runs| 07:02:21 INFO - PID 5002 | |0;ai-astar;112;114;105;107;117;109;110;101;110;114 07:02:21 INFO - PID 5002 | |1;audio-beat-detection;163;126;143;178;121;156;146;126;173;119 07:02:21 INFO - PID 5002 | |2;audio-dft;164;169;163;166;164;166;168;163;165;164 07:02:21 INFO - PID 5002 | |3;audio-fft;79;77;77;169;82;75;77;79;177;75 07:02:21 INFO - PID 5002 | |4;audio-oscillator;79;86;131;79;79;84;138;80;81;135 07:02:21 INFO - PID 5002 | |5;imaging-gaussian-blur;113;114;117;115;117;117;119;116;115;114 07:02:21 INFO - PID 5002 | |6;imaging-darkroom;151;156;150;151;151;151;151;151;150;153 07:02:21 INFO - PID 5002 | |7;imaging-desaturate;96;99;99;100;95;94;95;94;94;95 07:02:21 INFO - PID 5002 | |8;json-parse-financial;56;55;56;56;56;63;60;56;56;56 07:02:21 INFO - PID 5002 | |9;json-stringify-tinderbox;55;59;59;54;64;54;54;55;55;54 07:02:21 INFO - PID 5002 | |10;stanford-crypto-aes;94;92;81;93;91;82;89;83;83;80 07:02:21 INFO - PID 5002 | |11;stanford-crypto-ccm;129;136;126;132;134;131;130;128;136;171 07:02:21 INFO - PID 5002 | |12;stanford-crypto-pbkdf2;193;184;178;181;180;184;192;186;177;185 07:02:21 INFO - PID 5002 | |13;stanford-crypto-sha256-iterative;70;69;70;71;70;82;70;69;72;70 07:02:21 INFO - PID 5002 | __end_tp_report 07:02:21 INFO - PID 5002 | __start_cc_report 07:02:21 INFO - PID 5002 | _x_x_mozilla_cycle_collect,967 07:02:21 INFO - PID 5002 | __end_cc_report 07:02:21 INFO - PID 5002 | __startTimestamp1501164141331__endTimestamp 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | ------- Summary: start ------- 07:02:21 INFO - PID 5002 | Number of tests: 14 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:4.72 (4.3%) stddev-sans-first:4.95 07:02:21 INFO - PID 5002 | Values: 112.0 114.0 105.0 107.0 117.0 109.0 110.0 101.0 110.0 114.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:151.00 stddev:21.85 (14.5%) stddev-sans-first:22.19 07:02:21 INFO - PID 5002 | Values: 163.0 126.0 143.0 178.0 121.0 156.0 146.0 126.0 173.0 119.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:2.04 (1.2%) stddev-sans-first:2.12 07:02:21 INFO - PID 5002 | Values: 164.0 169.0 163.0 166.0 164.0 166.0 168.0 163.0 165.0 164.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#3] audio-fft Cycles:10 Average:96.70 Median:77.00 stddev:40.31 (52.4%) stddev-sans-first:42.24 07:02:21 INFO - PID 5002 | Values: 79.0 77.0 77.0 169.0 82.0 75.0 77.0 79.0 177.0 75.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:79.50 stddev:26.01 (32.7%) stddev-sans-first:26.74 07:02:21 INFO - PID 5002 | Values: 79.0 86.0 131.0 79.0 79.0 84.0 138.0 80.0 81.0 135.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.50 stddev:1.83 (1.6%) stddev-sans-first:1.66 07:02:21 INFO - PID 5002 | Values: 113.0 114.0 117.0 115.0 117.0 117.0 119.0 116.0 115.0 114.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:1.78 (1.2%) stddev-sans-first:1.88 07:02:21 INFO - PID 5002 | Values: 151.0 156.0 150.0 151.0 151.0 151.0 151.0 151.0 150.0 153.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:2.33 (2.5%) stddev-sans-first:2.47 07:02:21 INFO - PID 5002 | Values: 96.0 99.0 99.0 100.0 95.0 94.0 95.0 94.0 94.0 95.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:2.49 (4.5%) stddev-sans-first:2.62 07:02:21 INFO - PID 5002 | Values: 56.0 55.0 56.0 56.0 56.0 63.0 60.0 56.0 56.0 56.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:55.00 stddev:3.33 (6.1%) stddev-sans-first:3.50 07:02:21 INFO - PID 5002 | Values: 55.0 59.0 59.0 54.0 64.0 54.0 54.0 55.0 55.0 54.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:90.00 stddev:5.49 (6.1%) stddev-sans-first:5.17 07:02:21 INFO - PID 5002 | Values: 94.0 92.0 81.0 93.0 91.0 82.0 89.0 83.0 83.0 80.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:133.00 stddev:12.97 (9.8%) stddev-sans-first:13.56 07:02:21 INFO - PID 5002 | Values: 129.0 136.0 126.0 132.0 134.0 131.0 130.0 128.0 136.0 171.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:184.50 stddev:5.37 (2.9%) stddev-sans-first:4.61 07:02:21 INFO - PID 5002 | Values: 193.0 184.0 178.0 181.0 180.0 184.0 192.0 186.0 177.0 185.0 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:70.00 stddev:3.86 (5.5%) stddev-sans-first:4.07 07:02:21 INFO - PID 5002 | Values: 70.0 69.0 70.0 71.0 70.0 82.0 70.0 69.0 72.0 70.0 07:02:21 INFO - PID 5002 | -------- Summary: end -------- 07:02:21 INFO - PID 5002 | 07:02:21 INFO - PID 5002 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:02:22 INFO - TEST-INFO | 5002: exit 0 07:02:22 INFO - TEST-OK | kraken | took 63681ms 07:02:22 INFO - SUITE-END | took 1176s 07:02:22 INFO - Completed test suite (00:19:37) 07:02:22 INFO - javascript benchmark 07:02:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8332.0593373419, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.317270200555, 3153.385089907469, 3157.463231250687, 3163.0827060152565, 3178.2213357727346, 6127.601705889119, 6152.969235153823, 6256.812295631138, 6271.122042913996, 6314.652694101834, 6088.8477788055325, 6210.7205175767085, 6230.408111229437, 6237.095621134933, 6250.499960003201, 5660.9716951415285, 5690.260266165393, 5690.772369105231, 5719.914201286963, 5731.684757338345, 5726.055200891848, 5750.137479378106, 5755.82732518023, 5756.539476841843, 5766.7404966776385, 5706.800261990831, 5710.172025056364, 5727.169560413738, 5733.312002559699, 5748.82753517393, 5677.829665110033, 5690.174924635946, 5703.458171473703, 5721.914171287434, 5733.971330143323, 5610.158476228557, 5676.858078548028, 5696.401877802812, 5699.515541179005, 5810.448007439287, 6170.7223174957235, 6171.6297022178815, 6235.563510554263, 6241.375862413768, 6291.496680265568, 6490.156279683658, 6639.933600664028, 6643.0, 6730.2933192014625, 6739.292374300677, 6633.787643680996, 6691.531592788507, 6693.431058360045, 6694.799156025327, 6708.631025293607, 5450.209719590677, 6173.81478555644, 6208.192934918477, 6276.403741644536, 6294.7482100715915, 6836.794896153124, 6842.7605033823575, 6923.5499692519825, 6926.688299026556, 6931.341522555349, 6385.840353991188, 6493.22081350241, 6497.9350206498275, 6531.444827189742, 6623.834404139839, 6630.270670226271, 6643.900341494881, 6647.5346725729705, 6652.467802575782, 6660.433863121689, 5950.821475355746, 6558.901616475757, 6593.340665933369, 6593.637349945799, 6632.668366581652, 6597.439217666456, 6619.172603424572, 6702.731890724316, 6729.293424190488, 6747.325267473213, 5317.335333083364, 5322.707251101149, 5399.406065332811, 5406.91889621656, 5413.9729301353245, 4495.730256184639, 4597.816087356468, 4605.815767369335, 4612.53874612536, 4629.930551041737, 5804.100364443518, 5806.1000544915605, 5806.912896306559, 5806.941930580725, 5811.970940145272, 6613.537052406382, 6652.667366631649, 6701.463882889455, 6708.127943367429, 6709.7651582194385, 5778.884422311614, 5837.970810145922, 5844.211031510777, 5846.210761547221, 5847.707614619337, 5782.190493330937, 5794.681292528951, 5860.941390586125, 5880.206172166788, 5910.202122713465, 6424.646644434601, 6440.484761219185, 6442.098106265126, 6458.903116453257, 6479.870402591921, 6563.343665633399, 6636.2368327642935, 6653.800385988428, 6667.0, 6674.065630811593, 6437.549371543947, 6439.06633538125, 6445.355464453704, 6471.935280647133, 6476.417122459001, 5591.580631452576, 6562.376574225441, 6584.4732421405215, 6584.8024559263295, 6630.403263706289, 6653.135092437952, 6702.229243636849, 6729.394354508117, 6773.796786096425, 6779.186497620317, 6401.647909364843, 6516.967415162894, 6518.9569668852755, 6522.445592124533, 6554.737810487527, 6462.483001359786, 6471.611703297817, 6473.676316184078, 6478.963365861439, 6488.351164883474, 6406.295307516262, 6414.61512309263, 6432.2281326241155, 6437.420632143129, 6441.903371449338, 6495.772647957298, 6558.409743123142, 6616.503762217949, 6618.702158402787, 6654.301298363602, 6185.2886918003205, 6301.180846489927, 6304.9281622123435, 6321.241451025906, 6410.1987251593555], "value": 6069.709518903964, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.0795573157272, 825.3438516379479, 851.1190917400492, 852.6205838401912, 1182.4678894497479, 30697.539536906937, 31152.68847311529, 31224.531632025508, 41347.0, 42943.78528107363, 42930.57069429305, 43291.13417731643, 43352.3497147543, 43396.783016084955, 43483.13033739323, 7418.332350088491, 7805.765827025199, 8015.278624923756, 8043.0, 8056.8388632227325, 7878.842423151534, 7986.0, 7986.1614530474335, 7986.241307075818, 7992.160823113548, 7893.486923349992, 7946.841063178733, 7951.562664053475, 7955.920440795605, 7989.360851131924, 7953.164917683618, 8013.19868013194, 8013.2387423194705, 8016.759497215064, 8017.158198389144, 7853.096893857222, 7902.604869756489, 7907.327877130451, 7909.169537198626, 7913.327367173797, 37878.81060594707, 38016.23967520662, 38074.0, 38079.61920380789, 38175.0, 3468.0809585459874, 3505.106197919514, 3507.824608769551, 3520.7359448041498, 3533.8586456541707, 31136.53295200574, 31261.37477250465, 31294.687053129634, 31303.53044704331, 31329.373412531848, 4622.838200662961, 4809.519048095198, 4831.516848315176, 4866.148424025781, 4875.000624871893, 178934.0, 180317.0, 180494.0, 181020.0, 181625.0, 48094.75952620214, 48099.0, 48410.5158948406, 48415.75792121017, 48633.5136648629, 50038.74980625074, 50281.24578131331, 50413.747931260106, 50697.23954140691, 50816.49183508191, 14955.0, 15138.697226055418, 15163.620909477131, 15171.848281517043, 15200.391984320724, 10871.402072886067, 11142.665720028412, 11152.275102118336, 13622.93188534051, 13900.235487048309, 14014.71970560583, 14038.578842634737, 14072.155670659793, 14346.784798228035, 14355.78466323006, 5618.943810561842, 5864.179014937912, 5920.940790592039, 5951.732172052268, 5967.283925928917, 976.9706908792606, 984.6061575369766, 996.7159359582485, 1012.3622118065572, 1013.5742987945081, 21955.463117581618, 21958.780412195993, 22609.434764131027, 22918.08327666908, 23033.0, 1051.71603667011, 1052.0689190066694, 1073.6671631794168, 1085.9837102443469, 1088.8911108889206, 11533.539938018728, 11673.591424300279, 11732.178747487595, 11861.0, 12165.296858439826, 202345.0, 204858.0, 218619.0, 219217.0, 220138.0, 51741.48258517442, 52154.0, 52154.47845521572, 52159.217611735854, 52383.73808130935, 1480.6520467690084, 1495.1178804505394, 1505.2323315109372, 1506.1716056169064, 1510.2222355486933, 21696.24063157782, 21815.78184218201, 21969.67045494351, 22046.88976555107, 22081.116755329607, 37002.0, 37059.81470092632, 37138.25723485461, 37210.25579488449, 37229.62770372262, 189911.0, 190671.0, 191313.0, 191770.0, 192234.0, 30172.24569385783, 31018.534721978736, 34034.489482658275, 34172.82913585416, 34280.657193427745, 38018.8099059514, 42319.0, 42400.36399453949, 42537.14925701407, 42589.0, 29955.251118722208, 30324.848375758862, 30667.2333191672, 30677.0, 30815.691843081284, 28511.572326414705, 29666.25834354072, 30088.398232035674, 30203.395932081676, 30489.54265686061, 34405.655943440244, 34471.138221544665, 34544.30911381808, 34860.65139348574, 34978.825105874304, 27589.58615620727, 29568.704312957456, 30134.849325753232, 30452.543211852284, 30453.695463045085, 21873.453163671034, 22209.333719988426, 23751.287461376185, 24702.25893223206, 25030.74969250357], "value": 16797.819096311156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.7317524176017, 573.9783185929048, 578.9797357092502, 587.9323877754058, 588.58210670424, 21769.34691959242, 22170.334889953327, 22671.77328226717, 22760.772392276092, 22763.772362276373, 24376.146834860785, 25906.222813315584, 25985.87007064962, 26002.0, 26082.608760868603, 6546.9017964730565, 6705.094812200364, 6706.12820333356, 6710.42961348286, 6719.8656026879435, 6352.777652782153, 6407.070974708665, 6482.157319548475, 6489.22129344477, 6489.480841532666, 6054.485368743662, 6426.325235850239, 6439.549231553793, 6499.155109835715, 6499.577527460724, 6326.082718005863, 6460.870782584346, 6480.384363485485, 6487.156669632965, 6492.772752953648, 5937.554683398763, 5958.821235362946, 5964.284285885721, 5971.820845374646, 5976.312724036705, 27607.447851043067, 28508.287292817844, 28782.0, 28971.275718107005, 29975.250618734488, 1909.30310436691, 1963.4796778853472, 1963.9018049097488, 1965.0764140853776, 1969.4091772468203, 18467.538311542183, 18793.90603046976, 18946.715799263024, 18953.0, 18956.146973386094, 2260.9321720348416, 2287.0737351372554, 2329.813614910803, 2330.731965823935, 2350.048230466664, 128209.0, 131987.0, 132265.33867330698, 132704.0, 133422.33288833592, 13971.510997115052, 14745.705085898222, 14873.033252838532, 14920.104793712411, 14995.2502374883, 23295.53408931812, 23298.53402931932, 23432.0, 23451.530969380517, 23499.17752878641, 9888.456134912649, 9911.405315681082, 10073.345232559861, 10079.848802267972, 10108.39349639024, 9136.862947055799, 9194.609401555645, 9238.95380523093, 9325.114114159143, 9371.344005919656, 8374.246317831425, 8807.515586642668, 9089.5000774958, 9237.584308706124, 9345.719628411158, 2590.805689573252, 2591.3651155467032, 2684.7181045990283, 2759.406727553586, 2842.6873043965147, 915.4095608332589, 924.3529529329496, 962.3696478806393, 971.9951400242953, 978.5254151736402, 18821.90589047046, 18941.43175704731, 19119.044047797834, 19122.33071842479, 19527.218911243675, 966.9564869580745, 1023.7287118913493, 1032.7521394865328, 1039.859618951447, 1043.5147656339839, 10475.214358923111, 10528.0, 10571.682849514373, 10622.203334749925, 11083.445827708581, 476115.0, 480434.0, 487684.0, 506481.0, 512810.0, 119681.0, 121255.0, 124962.0, 125063.374683126, 126540.0, 1240.9503619855286, 1279.32195936154, 1295.2746461981321, 1303.6610481275127, 1307.5488956310248, 16090.015468289725, 17068.146592670564, 17237.0, 17523.474295771146, 19905.60188796245, 54123.458765411844, 55175.724121379135, 55235.0, 55934.16098758441, 56398.718006409705, 64005.0, 64392.356076438635, 64927.67536162289, 64996.0, 65339.0, 12201.877981220074, 14608.488702895347, 14938.402463901322, 14966.700665986837, 15007.324670390077, 17379.739303910705, 19257.13342899601, 19321.130549125042, 19541.0, 24660.383490412165, 18823.0, 18841.717374239124, 19092.522686932938, 19215.0, 19238.326658566883, 15252.923735381251, 15436.922815385851, 16087.276072576997, 17040.659186816443, 17584.91207543954, 19222.7116593254, 19425.708614370513, 19879.204831806564, 19949.401517954484, 19960.101795418952, 14535.27323633793, 14558.927205363905, 14639.92680036593, 14648.0, 14678.559643210721, 19028.0, 19070.14184361679, 19291.93894335825, 19423.90288048607, 19655.410337689893], "value": 11828.688334467271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.2898999035515, 1342.087380581205, 1369.9863001369986, 1376.0780277214265, 1383.3774801339393, 13036.804447933277, 13498.460061597536, 13565.389557469913, 13581.185128892273, 13731.17612943224, 13596.456141754343, 13744.381502832372, 13766.587002389919, 13800.309984500786, 13806.378712957916, 2621.1481268587736, 2689.072270066824, 2694.434168824549, 2694.595810628402, 2694.892204311825, 2191.3864118046895, 2290.5991451496006, 2484.167803785734, 2506.774390304872, 2594.1439325022698, 2550.9489810203786, 2560.6927168739776, 2561.2700380391593, 2562.551553478143, 2564.833285836424, 2492.887820048102, 2547.923562293125, 2566.5765148750434, 2572.601246806748, 2577.1624222127884, 2519.8362106463023, 2545.669063021814, 2559.078731656602, 2561.5005074010573, 2562.2569454858067, 13764.380602872894, 13808.447662093504, 13919.443222271097, 13929.442822287096, 13937.372818223204, 7544.4718869679145, 7848.646810893466, 7849.725259615943, 7855.253750893656, 7862.960685196595, 4635.281531362644, 4787.904241915177, 4814.831480898151, 4982.950170498285, 5023.2214006829, 1826.4520643806939, 1839.0804597701149, 1882.9623407531772, 1902.5909429472729, 1908.2748555548803, 21059.473513162142, 21148.0, 21185.576288474145, 21274.574508509897, 21362.0, 6360.459360954278, 6458.580192287486, 6502.577332473374, 6611.404973552403, 6631.0, 14902.850971490363, 14907.627309317353, 14913.403463861325, 14919.328630211667, 14923.403063877324, 7346.706131754777, 7533.359664428475, 7540.9622951884885, 7541.924580754122, 7549.7357592483995, 6742.797716068526, 6856.828579285458, 6939.514234003672, 6975.441964642816, 7119.6084215368655, 5069.771860266297, 5177.58579313654, 5218.869528261824, 5220.295260139908, 5228.2941802856885, 1435.1245740098532, 1464.6777708904024, 1507.487454265555, 1528.2969833876318, 1547.7910482085, 815.8980127484065, 824.6660102658433, 826.1325608111459, 832.5046597274612, 852.6418904060309, 6260.40526150015, 6557.0, 7835.138134805167, 8041.195880411912, 8123.228293312126, 889.3996552327153, 907.514479753342, 927.3647551427159, 959.4627008875052, 971.8153550825461, 4550.453945526492, 4613.746243956548, 4617.445906491175, 4733.148033354029, 4774.761261936958, 17930.0, 18887.81112188888, 18894.05529723508, 18904.716429253298, 18930.621387572446, 17815.821841781417, 18967.146478408504, 19012.144453499626, 19049.523761906064, 19086.427407177805, 10817.621383251548, 10896.727581810519, 10946.507407166697, 10974.122070234362, 11039.558417663364, 7145.0, 7636.694532218649, 7738.651760670896, 7824.374050076094, 7859.921400786147, 16044.43844465438, 16383.836161638708, 16703.0, 17024.319027238773, 17041.573960651083, 15995.0, 16300.347986080424, 16918.154092295088, 17068.0, 17147.228374723418, 11407.657770266906, 11585.0, 11638.301701897575, 11646.70883227926, 11648.88351116478, 12750.68123296925, 12792.296423696785, 13082.476700931857, 13205.537806176737, 13233.602991910258, 9576.281778866474, 10269.537870795682, 10461.9476902615, 10484.842727358942, 10604.257701960789, 9725.173360264456, 10109.898901011189, 10138.290319677551, 10390.22073344487, 10398.27212095146, 8574.31405487572, 8663.870041949502, 8665.696700615448, 8668.956655216683, 8674.219320261207, 6337.334579869232, 6588.275289718032, 6639.402453779183, 6687.130673012477, 6764.3573860483175, 6613.5701179425105, 6658.966705166443, 6679.131712877295, 6716.0, 6752.831179220559], "value": 6173.547799246755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.0653111036749, 497.44396382225705, 517.3145582103714, 520.4925197932016, 525.1545012529826, 6226.567889385438, 6231.657258850767, 6256.655883926388, 6293.465055470279, 6319.336469670688, 5848.532117430606, 6011.54913381497, 6056.333803281646, 6127.877442451148, 6162.815115546529, 4950.4307004694565, 4961.3798275215595, 4970.452036386702, 4980.77586508608, 4986.675866068694, 4930.3344048553345, 4942.258661200813, 4957.801687932497, 4976.203807390818, 5009.49905009498, 4764.809407623691, 4894.77973491192, 4899.510048995107, 4928.433230178522, 4938.777755001033, 4905.583025442842, 4918.754062296871, 4922.384701912261, 4956.578690811285, 4961.0, 4423.093265880487, 4426.712263702849, 4435.1573201092015, 4438.334249862514, 4447.0, 6064.939350606482, 6085.2697676278685, 6088.604240724383, 6098.54260930432, 6104.389561043905, 5718.5711071669375, 5728.427157284238, 5735.340435849847, 5737.913931291034, 5763.596548241625, 6551.082848401227, 6560.901586476207, 6570.901436478457, 6575.441087507567, 6621.404073633396, 4833.854984350475, 4840.273958906157, 4846.806127754886, 4875.293082503053, 4882.707037577757, 6868.519203655746, 6960.617166055865, 6971.233164351917, 6986.650667466657, 6994.300569942965, 4968.354113965162, 4969.90060198794, 4972.5027497249985, 4990.675606085665, 5037.19404895215, 5059.56993655536, 5067.5185857343495, 5075.264086707407, 5079.619028572798, 5091.770870310771, 5678.0, 5685.573581981368, 5700.144978253295, 5710.343310519261, 5735.369109397963, 6502.536929190989, 6550.7707230246715, 6572.079908812674, 6588.275289718127, 6630.867382652416, 1618.4335482581002, 1684.292597109217, 1687.4768821665077, 1713.083500327319, 1720.1657196259805, 1183.6981569699844, 1205.878532964334, 1217.3061355027548, 1221.8594861590852, 1225.7609766095704, 5683.687397193194, 5718.857028574235, 5739.225204597409, 5740.138979153077, 5767.0, 6438.0, 6557.967030220551, 6672.532922695462, 6714.328567143344, 6730.596164230162, 5692.117721753135, 5726.1410788381245, 5744.224529688438, 5746.2529871116485, 5834.978878696211, 3544.80503572306, 3549.5917969433845, 3560.501529785832, 3561.7765921840773, 3577.964220357815, 6529.575577587441, 6566.868662626721, 6570.047343135218, 6600.80197594073, 6632.9336706633285, 6836.026328546998, 6882.0, 6958.37374636275, 6962.582245065312, 6982.895256571155, 6410.551261411843, 6523.151990241238, 6550.6069635822005, 6596.175478065242, 6619.0, 6651.405951678752, 6688.4983626229205, 6699.598024118569, 6715.485978600749, 6742.5280230383405, 6565.704543295658, 6608.669566521751, 6688.83277918056, 6703.3296670332575, 6709.698063587052, 6461.224653041665, 6573.671316434255, 6599.175103112111, 6610.537262391779, 6631.933680663132, 5515.227868098389, 5518.172274158908, 5563.916541251965, 5570.470805273492, 5582.944170558405, 6780.288069752803, 6803.93196068033, 6811.489138314745, 6836.965815170893, 6843.794686159423, 6548.410643042149, 6591.5056370773345, 6611.570247933869, 6611.768588099393, 6623.138991931018, 6284.497240220863, 6591.901121483277, 6593.571417857824, 6634.601923884389, 6649.900251496135, 6153.261608606996, 6245.156903817927, 6336.827686877942, 6398.648074355769, 6437.452816510649, 6388.233411990591, 6411.069760471639, 6457.128287681103, 6462.931861804178, 6587.374199451045, 6119.908201376894, 6159.19930409044, 6197.96901015492, 6202.844928876814, 6231.594946328474], "value": 5054.049481233224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.7183165471223, 887.0, 899.5547204133952, 902.2376092202092, 908.9728606674465, 16691.666166676674, 17166.055866927312, 17320.307187712493, 17331.91334043328, 20719.274825381115, 16094.436694715687, 17140.14299285037, 17150.828491715078, 17182.914085429587, 17197.570060748487, 1004.7387679203423, 1010.7826817234293, 1012.266107072374, 1012.792377562598, 1015.3958394755109, 969.3602222533129, 993.2997236947934, 1039.4542864995863, 1042.0569384706853, 1045.5556388534842, 1100.5707773968159, 1109.4619109731773, 1112.0158659586284, 1112.0491979357614, 1112.3937454087502, 1094.031781873048, 1101.9944900275486, 1102.0412241349998, 1103.5751235774205, 1104.2325583719319, 800.2597597222604, 805.8912046873714, 809.951402915827, 809.9878501822418, 813.2924355810483, 18258.543536411562, 19071.90464047671, 19092.71360929587, 19141.712874306897, 19271.51821204481, 20276.594468110554, 20346.898265508727, 20566.97165141737, 20822.0, 20895.37313880586, 15542.689146217012, 15575.143367114804, 15716.135612541306, 15738.370465181379, 15922.681546369007, 3461.567304086989, 3531.94702079469, 3546.7517273790845, 3548.538689970313, 3549.4143466328023, 115915.42042289818, 117710.0, 118034.0, 123267.0, 124498.0, 15929.362825487082, 16295.0, 16295.185240737916, 16303.103329317002, 16316.836831631768, 29963.700362996093, 29992.400151996837, 30035.69964300373, 30045.0, 30068.24829379283, 8414.663413463515, 8424.578771061422, 8462.238398544161, 8547.230749232598, 8578.914210857936, 4043.7169398142437, 4136.400221967798, 4142.896427589334, 4151.4395556599475, 4155.397467367276, 4905.901881962341, 4905.950940490621, 5112.795488180431, 5688.914666280009, 5861.794837180763, 999.5352161245056, 1024.3956065921143, 1029.3463650581934, 1034.622362837559, 1035.8446233065101, 640.4172203294979, 645.3772109913956, 679.188369897977, 679.755288096285, 688.944884409246, 11058.612948546923, 13329.733405332034, 13657.795133073012, 13741.381637826322, 13811.792823107662, 642.958207716497, 655.0763423572739, 663.5554178700282, 674.8279188806823, 675.9628220447825, 4959.231319145538, 5275.96631936638, 5306.655067420683, 5414.996451313039, 5429.891402171935, 99175.50412247893, 102044.48977755064, 102462.48768756108, 102662.0, 104272.47863760633, 84371.0, 85104.0, 85587.57206214053, 88066.0, 90635.54682226546, 74823.62588187025, 77158.61420692973, 78983.0, 81321.59339203384, 81491.18508814955, 11639.185257031926, 12280.508779649072, 12489.313087779896, 12760.6809829755, 12790.232586044867, 32980.340393192484, 34096.0, 35078.12304692403, 35293.82353088218, 37400.812995935936, 45130.54869451263, 45219.773901130284, 46349.0, 47224.52775472201, 65409.0565924525, 17301.913490432467, 17684.823151768316, 17936.372226971995, 18060.458186254433, 18262.0, 20797.272095476586, 20920.47698807542, 21144.682829757257, 21385.25151619686, 21424.892875535523, 17953.829707318702, 18805.90597047006, 18911.90544047326, 18970.905145474186, 19092.33176838804, 19413.223471061, 19531.70702439436, 19537.413877583695, 19555.60888782188, 19734.60530789405, 17734.73397899007, 18543.53641158982, 18811.435656929767, 19017.904910475358, 19431.514212144808, 12606.49574017029, 12673.366331683195, 12695.746085078432, 12834.55079072228, 13389.866101339252, 14104.294785260901, 14196.361163747863, 14370.425182992563, 14374.281285935871, 14452.2051287176], "value": 8891.10882790096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 105.0, 107.0, 117.0, 109.0, 110.0, 101.0, 110.0, 114.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 143.0, 178.0, 121.0, 156.0, 146.0, 126.0, 173.0, 119.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 169.0, 163.0, 166.0, 164.0, 166.0, 168.0, 163.0, 165.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 169.0, 82.0, 75.0, 77.0, 79.0, 177.0, 75.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 131.0, 79.0, 79.0, 84.0, 138.0, 80.0, 81.0, 135.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 117.0, 115.0, 117.0, 117.0, 119.0, 116.0, 115.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 156.0, 150.0, 151.0, 151.0, 151.0, 151.0, 151.0, 150.0, 153.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 99.0, 100.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 63.0, 60.0, 56.0, 56.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 59.0, 54.0, 64.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 81.0, 93.0, 91.0, 82.0, 89.0, 83.0, 83.0, 80.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 126.0, 132.0, 134.0, 131.0, 130.0, 128.0, 136.0, 171.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 184.0, 178.0, 181.0, 180.0, 184.0, 192.0, 186.0, 177.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 71.0, 70.0, 82.0, 70.0, 69.0, 72.0, 70.0], "value": 71.3, "unit": "score"}]}]} 07:02:22 INFO - Return code: 0 07:02:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:02:22 INFO - # TBPL SUCCESS # 07:02:22 INFO - Running post-action listener: _package_coverage_data 07:02:22 INFO - Running post-action listener: _resource_record_post_action 07:02:22 INFO - [mozharness: 2017-07-27 14:02:22.614060Z] Finished run-tests step (success) 07:02:22 INFO - Running post-run listener: _resource_record_post_run 07:02:22 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 438272; Write bytes: 443858944; Read time: 328; Write time: 271020 07:02:22 INFO - TinderboxPrint: CPU usage
13.1% 07:02:22 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 328 07:02:22 INFO - TinderboxPrint: I/O write bytes / time
443,858,944 / 271,020 07:02:22 INFO - TinderboxPrint: CPU idle
8,274.2 (86.8%) 07:02:22 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 07:02:22 INFO - TinderboxPrint: Swap in / out
0 / 0 07:02:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 121024512; Read time: 68; Write time: 85020 07:02:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:02:22 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 430080; Write bytes: 321712128; Read time: 252; Write time: 185944 07:02:23 INFO - Running post-run listener: _upload_blobber_files 07:02:23 INFO - Blob upload gear active. 07:02:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:02:23 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 07:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:02:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:02:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:02:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:02:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:36 INFO - (blobuploader) - INFO - Done attempting. 07:02:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:02:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:37 INFO - (blobuploader) - INFO - Done attempting. 07:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:38 INFO - (blobuploader) - INFO - Done attempting. 07:02:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:02:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:39 INFO - (blobuploader) - INFO - Done attempting. 07:02:39 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:39 INFO - Return code: 0 07:02:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:02:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a959dbaa1322b281397096c23814908dddda412ad0f7a08d0c631576b40310de1ea93e5f93f4c6ffbb8d3005c59b385113b7ce550e3c805287c1123257d38af9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4830e668f6647f3c3cddece15d9f0ee55f413e22d869bb2e6508fbf97f719f54ebb3061d134f451e1c77ac13330923d0ea87f0d588ebcd2cc79c4f7e6f3289e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41f5ba2f2442001aa88694ff4d4e71f3c24ca5d9f38e4f9e5f4fa3ee78076289145a5789f6abf3fdc68654f51da3efc78423186d5b0d8acbeb3414b210ae9613", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2fc74ac1f84c48a5800048eafe7f13859e498ddc76d39c94d48252c2f57d786c3550f30355c49822a0e0c9e15c5b4ba86030518447d311efb15129a773cc1bb"} 07:02:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:02:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:02:39 INFO - Contents: 07:02:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a959dbaa1322b281397096c23814908dddda412ad0f7a08d0c631576b40310de1ea93e5f93f4c6ffbb8d3005c59b385113b7ce550e3c805287c1123257d38af9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4830e668f6647f3c3cddece15d9f0ee55f413e22d869bb2e6508fbf97f719f54ebb3061d134f451e1c77ac13330923d0ea87f0d588ebcd2cc79c4f7e6f3289e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41f5ba2f2442001aa88694ff4d4e71f3c24ca5d9f38e4f9e5f4fa3ee78076289145a5789f6abf3fdc68654f51da3efc78423186d5b0d8acbeb3414b210ae9613", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2fc74ac1f84c48a5800048eafe7f13859e498ddc76d39c94d48252c2f57d786c3550f30355c49822a0e0c9e15c5b4ba86030518447d311efb15129a773cc1bb"} 07:02:39 INFO - Running post-run listener: copy_logs_to_upload_dir 07:02:39 INFO - Copying logs to upload dir... 07:02:39 INFO - mkdir: /builds/slave/test/build/upload/logs 07:02:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.209404 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-07-27 07:02:39.307231) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:39.312147) ========= 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=3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442 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/sha512/a959dbaa1322b281397096c23814908dddda412ad0f7a08d0c631576b40310de1ea93e5f93f4c6ffbb8d3005c59b385113b7ce550e3c805287c1123257d38af9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4830e668f6647f3c3cddece15d9f0ee55f413e22d869bb2e6508fbf97f719f54ebb3061d134f451e1c77ac13330923d0ea87f0d588ebcd2cc79c4f7e6f3289e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41f5ba2f2442001aa88694ff4d4e71f3c24ca5d9f38e4f9e5f4fa3ee78076289145a5789f6abf3fdc68654f51da3efc78423186d5b0d8acbeb3414b210ae9613", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2fc74ac1f84c48a5800048eafe7f13859e498ddc76d39c94d48252c2f57d786c3550f30355c49822a0e0c9e15c5b4ba86030518447d311efb15129a773cc1bb"} build_url:https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a959dbaa1322b281397096c23814908dddda412ad0f7a08d0c631576b40310de1ea93e5f93f4c6ffbb8d3005c59b385113b7ce550e3c805287c1123257d38af9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4830e668f6647f3c3cddece15d9f0ee55f413e22d869bb2e6508fbf97f719f54ebb3061d134f451e1c77ac13330923d0ea87f0d588ebcd2cc79c4f7e6f3289e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41f5ba2f2442001aa88694ff4d4e71f3c24ca5d9f38e4f9e5f4fa3ee78076289145a5789f6abf3fdc68654f51da3efc78423186d5b0d8acbeb3414b210ae9613", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2fc74ac1f84c48a5800048eafe7f13859e498ddc76d39c94d48252c2f57d786c3550f30355c49822a0e0c9e15c5b4ba86030518447d311efb15129a773cc1bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:39.336901) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:39.337195) ========= 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=3836458cccd887f2d2de3cf1000001de-1501160567.566887-278740442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:39.418492) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 07:02:39.418785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 07:02:39.419068) ========= ========= Total master_lag: 0.18 =========