builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1501162895.46 results: success (0) revision: 658cba6a971257e2ba39715ec938256dfc414776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.461233) ========= 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:35.461616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.461898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.480708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.480974) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 06:41:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-07-27 06:41:39 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.590580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.590899) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020920 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.646468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:35.646791) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 06:41:39,525 truncating revision to first 12 chars 2017-07-27 06:41:39,525 Setting DEBUG logging. 2017-07-27 06:41:39,525 attempt 1/10 2017-07-27 06:41:39,525 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:39,824 unpacking tar archive at: mozilla-central-658cba6a9712/testing/mozharness/ program finished with exit code 0 elapsedTime=0.589194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:36.252763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:36.253322) ========= script_repo_revision: 658cba6a971257e2ba39715ec938256dfc414776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:36.254107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:36.254668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 06:41:36.269122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-27 06:41:36.269885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:41:40 INFO - MultiFileLogger online at 20170727 06:41:40 in /builds/slave/test 06:41:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:41:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:40 INFO - {'append_to_log': False, 06:41:40 INFO - 'base_work_dir': '/builds/slave/test', 06:41:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:41:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:40 INFO - 'branch': 'Firefox-Non-PGO', 06:41:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:40 INFO - 'code_coverage': False, 06:41:40 INFO - 'config_files': ('talos/linux_config.py',), 06:41:40 INFO - 'default_actions': ('clobber', 06:41:40 INFO - 'read-buildbot-config', 06:41:40 INFO - 'download-and-extract', 06:41:40 INFO - 'populate-webroot', 06:41:40 INFO - 'create-virtualenv', 06:41:40 INFO - 'install', 06:41:40 INFO - 'setup-mitmproxy', 06:41:40 INFO - 'run-tests'), 06:41:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:40 INFO - 'disable_ccov_upload': False, 06:41:40 INFO - 'download_minidump_stackwalk': True, 06:41:40 INFO - 'download_symbols': 'ondemand', 06:41:40 INFO - 'enable_stylo': False, 06:41:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:40 INFO - 'gecko_profile': False, 06:41:40 INFO - 'gecko_profile_interval': 0, 06:41:40 INFO - 'installer_path': 'installer.exe', 06:41:40 INFO - 'log_level': 'info', 06:41:40 INFO - 'log_name': 'talos', 06:41:40 INFO - 'log_to_console': True, 06:41:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:41:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:41:40 INFO - 'opt_config_files': (), 06:41:40 INFO - 'pip_index': False, 06:41:40 INFO - 'suite': 'dromaeojs-e10s', 06:41:40 INFO - 'system_bits': '32', 06:41:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:40 INFO - 'title': 'talos-linux64-ix-068', 06:41:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:40 INFO - 'use_talos_json': True, 06:41:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:40 INFO - 'work_dir': 'build'} 06:41:40 INFO - [mozharness: 2017-07-27 13:41:40.260980Z] Running clobber step. 06:41:40 INFO - Running pre-action listener: _resource_record_pre_action 06:41:40 INFO - Running main action method: clobber 06:41:40 INFO - rmtree: /builds/slave/test/build 06:41:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:41 INFO - Running post-action listener: _resource_record_post_action 06:41:41 INFO - [mozharness: 2017-07-27 13:41:41.288056Z] Finished clobber step (success) 06:41:41 INFO - [mozharness: 2017-07-27 13:41:41.288162Z] Running read-buildbot-config step. 06:41:41 INFO - Running pre-action listener: _resource_record_pre_action 06:41:41 INFO - Running main action method: read_buildbot_config 06:41:41 INFO - Using buildbot properties: 06:41:41 INFO - { 06:41:41 INFO - "project": "", 06:41:41 INFO - "product": "firefox", 06:41:41 INFO - "who": "archaeopteryx@coole-files.de", 06:41:41 INFO - "installer_path": "public/build/target.tar.bz2", 06:41:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:41:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:41:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:41:41 INFO - "stage_platform": "linux64", 06:41:41 INFO - "basedir": "/builds/slave/test", 06:41:41 INFO - "buildnumber": 1036, 06:41:41 INFO - "platform": "ubuntu64_hw", 06:41:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:41:41 INFO - "slavebuilddir": "test", 06:41:41 INFO - "taskId": "IbhKMOkDSDGA9SB4wLYG5w", 06:41:41 INFO - "branch": "mozilla-central", 06:41:41 INFO - "script_repo_revision": "production", 06:41:41 INFO - "revision": "658cba6a971257e2ba39715ec938256dfc414776", 06:41:41 INFO - "slavename": "talos-linux64-ix-068", 06:41:41 INFO - "repo_path": "mozilla-central" 06:41:41 INFO - } 06:41:41 INFO - Finding installer, test and symbols from parent task. 06:41:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbhKMOkDSDGA9SB4wLYG5w'}, attempt #1 06:41:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbhKMOkDSDGA9SB4wLYG5w'}, attempt #1 06:41:42 INFO - Task dependencies: NOjUXIa0QK-7lZYie13cWw 06:41:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw'}, attempt #1 06:41:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:41:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/test_packages.json 06:41:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip 06:41:42 INFO - Running post-action listener: _resource_record_post_action 06:41:42 INFO - [mozharness: 2017-07-27 13:41:42.656282Z] Finished read-buildbot-config step (success) 06:41:42 INFO - [mozharness: 2017-07-27 13:41:42.656505Z] Running download-and-extract step. 06:41:42 INFO - Running pre-action listener: _resource_record_pre_action 06:41:42 INFO - Running main action method: download_and_extract 06:41:42 INFO - mkdir: /builds/slave/test/build/tests 06:41:42 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:42 INFO - trying https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.test_packages.json 06:41:42 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:42 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:43 INFO - Downloaded 989 bytes. 06:41:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:41:43 INFO - Using the following test package requirements: 06:41:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:41:43 INFO - u'common': [u'target.common.tests.zip'], 06:41:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:41:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:41:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:41:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:41:43 INFO - u'mozbase': [u'target.common.tests.zip'], 06:41:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:41:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:41:43 INFO - u'web-platform': [u'target.common.tests.zip', 06:41:43 INFO - u'target.web-platform.tests.tar.gz'], 06:41:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:41:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:41:43 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:43 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:43 INFO - Fetch https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip into memory 06:41:44 INFO - Content-Length response header: 72550620 06:41:44 INFO - Bytes received: 72550620 06:41:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:41:55 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:55 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:55 INFO - Fetch https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.common.tests.zip into memory 06:41:57 INFO - Content-Length response header: 72550620 06:41:57 INFO - Bytes received: 72550620 06:42:09 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:09 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:09 INFO - Fetch https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.talos.tests.zip into memory 06:42:09 INFO - Content-Length response header: 14496465 06:42:09 INFO - Bytes received: 14496465 06:42:10 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:10 INFO - trying https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:42:10 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:10 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:11 INFO - Downloaded 62082698 bytes. 06:42:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:42:11 INFO - mkdir: /builds/slave/test/properties 06:42:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:11 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:11 INFO - Contents: 06:42:11 INFO - build_url:https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 06:42:11 INFO - Running post-action listener: _resource_record_post_action 06:42:11 INFO - Running post-action listener: set_extra_try_arguments 06:42:11 INFO - [mozharness: 2017-07-27 13:42:11.227741Z] Finished download-and-extract step (success) 06:42:11 INFO - [mozharness: 2017-07-27 13:42:11.227838Z] Running populate-webroot step. 06:42:11 INFO - Running pre-action listener: _resource_record_pre_action 06:42:11 INFO - Running main action method: populate_webroot 06:42:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:42:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:42:11 INFO - 'tests': ['damp', 'tps']}, 06:42:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:42:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:42:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:42:11 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:11 INFO - 'ts_paint', 06:42:11 INFO - 'tpaint', 06:42:11 INFO - 'sessionrestore', 06:42:11 INFO - 'sessionrestore_many_windows', 06:42:11 INFO - 'sessionrestore_no_auto_restore', 06:42:11 INFO - 'tabpaint']}, 06:42:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:42:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:42:11 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:42:11 INFO - 'talos_options': ['--mitmproxy', 06:42:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:42:11 INFO - '--firstNonBlankPaint'], 06:42:11 INFO - 'tests': ['quantum_pageload_google', 06:42:11 INFO - 'quantum_pageload_youtube', 06:42:11 INFO - 'quantum_pageload_amazon', 06:42:11 INFO - 'quantum_pageload_facebook']}, 06:42:11 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:42:11 INFO - 'talos_options': ['--stylo', 06:42:11 INFO - '--mitmproxy', 06:42:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:42:11 INFO - '--firstNonBlankPaint'], 06:42:11 INFO - 'tests': ['quantum_pageload_google', 06:42:11 INFO - 'quantum_pageload_youtube', 06:42:11 INFO - 'quantum_pageload_amazon', 06:42:11 INFO - 'quantum_pageload_facebook']}, 06:42:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:11 INFO - 'tsvgr_opacity', 06:42:11 INFO - 'tart', 06:42:11 INFO - 'tscrollx', 06:42:11 INFO - 'cart', 06:42:11 INFO - 'tsvg_static']}, 06:42:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:42:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:42:11 INFO - 'talos_options': ['--xperf_path', 06:42:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:11 INFO - 'tests': ['tp5n']}}} 06:42:11 INFO - Running post-action listener: _resource_record_post_action 06:42:11 INFO - [mozharness: 2017-07-27 13:42:11.235138Z] Finished populate-webroot step (success) 06:42:11 INFO - [mozharness: 2017-07-27 13:42:11.235228Z] Running create-virtualenv step. 06:42:11 INFO - Running pre-action listener: _resource_record_pre_action 06:42:11 INFO - Running main action method: create_virtualenv 06:42:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:42:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:42:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:11 INFO - Using real prefix '/usr' 06:42:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:11 INFO - Installing distribute.............................................................................................................................................................................................done. 06:42:13 INFO - Installing pip.................done. 06:42:13 INFO - Return code: 0 06:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:42:14 INFO - Reading from file tmpfile_stdout 06:42:14 INFO - Output received: 06:42:14 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:14 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', 'pip>=1.5'] 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 pip>=1.5 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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:42:14 INFO - Cleaning up... 06:42:14 INFO - Return code: 0 06:42:14 INFO - Installing psutil>=3.1.1 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', '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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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 psutil>=3.1.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:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:16 INFO - Installing collected packages: psutil 06:42:16 INFO - Running setup.py install for psutil 06:42:16 INFO - building 'psutil._psutil_linux' extension 06:42:16 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:16 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:16 INFO - building 'psutil._psutil_posix' extension 06:42:16 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:17 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:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:17 INFO - Successfully installed psutil 06:42:17 INFO - Cleaning up... 06:42:17 INFO - Return code: 0 06:42:17 INFO - Installing mozsystemmonitor==0.3 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', '--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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', '--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:17 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: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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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 - Downloading/unpacking mozsystemmonitor==0.3 06:42:17 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:17 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:17 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:17 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:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:42:18 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:18 INFO - Installing collected packages: mozsystemmonitor 06:42:18 INFO - Running setup.py install for mozsystemmonitor 06:42:18 INFO - Successfully installed mozsystemmonitor 06:42:18 INFO - Cleaning up... 06:42:18 INFO - Return code: 0 06:42:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:42:18 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:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:18 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:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:18 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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:18 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:18 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:18 INFO - Using env: {'DISPLAY': ':0', 06:42:18 INFO - 'HOME': '/home/cltbld', 06:42:18 INFO - 'LANG': 'en_US.UTF-8', 06:42:18 INFO - 'LANGUAGE': 'en_US:en', 06:42:18 INFO - 'LOGNAME': 'cltbld', 06:42:18 INFO - 'MAIL': '/var/mail/cltbld', 06:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:18 INFO - 'MOZ_NO_REMOTE': '1', 06:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:18 INFO - 'NO_EM_RESTART': '1', 06:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:18 INFO - 'PWD': '/builds/slave/test', 06:42:18 INFO - 'SHELL': '/bin/bash', 06:42:18 INFO - 'SHLVL': '1', 06:42:18 INFO - 'TERM': 'linux', 06:42:18 INFO - 'TMOUT': '86400', 06:42:18 INFO - 'USER': 'cltbld', 06:42:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 06:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:18 INFO - '_': '/tools/buildbot/bin/python'} 06:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:18 INFO - Downloading/unpacking jsonschema==2.5.1 06:42:18 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:18 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:18 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:18 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:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:42:19 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:19 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:19 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:19 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:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:20 INFO - warning: no files found matching '*.txt' 06:42:20 INFO - no previously-included directories found matching 'build' 06:42:20 INFO - no previously-included directories found matching 'dist' 06:42:20 INFO - no previously-included directories found matching '.git*' 06:42:20 INFO - Installing collected packages: jsonschema, functools32 06:42:20 INFO - Running setup.py install for functools32 06:42:20 INFO - warning: no files found matching '*.txt' 06:42:20 INFO - no previously-included directories found matching 'build' 06:42:20 INFO - no previously-included directories found matching 'dist' 06:42:20 INFO - no previously-included directories found matching '.git*' 06:42:20 INFO - Successfully installed jsonschema functools32 06:42:20 INFO - Cleaning up... 06:42:20 INFO - Return code: 0 06:42:20 INFO - Installing functools32==3.2.3-2 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', '--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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', '--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:20 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: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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:42:20 INFO - Cleaning up... 06:42:20 INFO - Return code: 0 06:42:20 INFO - Installing blobuploader==1.2.4 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', '--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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', '--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:20 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: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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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 - Downloading/unpacking blobuploader==1.2.4 06:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:21 INFO - Downloading blobuploader-1.2.4.tar.gz 06:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:42:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:42:22 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:22 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 - 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:22 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:42:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:42:22 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:22 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 - 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:22 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 docopt-0.6.1.tar.gz 06:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:42:22 INFO - Installing collected packages: blobuploader, requests, docopt 06:42:22 INFO - Running setup.py install for blobuploader 06:42:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:42:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:42:22 INFO - Running setup.py install for requests 06:42:23 INFO - Running setup.py install for docopt 06:42:23 INFO - Successfully installed blobuploader requests docopt 06:42:23 INFO - Cleaning up... 06:42:23 INFO - Return code: 0 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', '--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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', '--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:23 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: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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:23 INFO - Running setup.py (path:/tmp/pip-wQvNP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:23 INFO - Running setup.py (path:/tmp/pip-QWU0PJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:23 INFO - Running setup.py (path:/tmp/pip-JOXFM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:23 INFO - Running setup.py (path:/tmp/pip-s0sejI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:23 INFO - Running setup.py (path:/tmp/pip-oAxdh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:23 INFO - Running setup.py (path:/tmp/pip-LN84mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:23 INFO - Running setup.py (path:/tmp/pip-yn4iXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:23 INFO - Running setup.py (path:/tmp/pip-LWg3QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:24 INFO - Running setup.py (path:/tmp/pip-hK4f5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:24 INFO - Running setup.py (path:/tmp/pip-nXvHH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:24 INFO - Running setup.py (path:/tmp/pip-u6sSCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:24 INFO - Running setup.py (path:/tmp/pip-FgBauh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:24 INFO - Running setup.py (path:/tmp/pip-ddZu8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:24 INFO - Running setup.py (path:/tmp/pip-oUgy10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:24 INFO - Running setup.py (path:/tmp/pip-V1THY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:24 INFO - Running setup.py (path:/tmp/pip-puYlED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:24 INFO - Running setup.py (path:/tmp/pip-uq8nxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:42:24 INFO - Running setup.py install for manifestparser 06:42:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:42:24 INFO - Running setup.py install for mozcrash 06:42:24 INFO - Running setup.py install for mozdebug 06:42:24 INFO - Running setup.py install for mozdevice 06:42:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Running setup.py install for mozfile 06:42:25 INFO - Running setup.py install for mozhttpd 06:42:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Running setup.py install for mozinfo 06:42:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Running setup.py install for mozInstall 06:42:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Running setup.py install for mozleak 06:42:25 INFO - Running setup.py install for mozlog 06:42:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Running setup.py install for moznetwork 06:42:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:42:25 INFO - Running setup.py install for mozprocess 06:42:25 INFO - Running setup.py install for mozprofile 06:42:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:42:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:42:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:42:26 INFO - Running setup.py install for mozrunner 06:42:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:42:26 INFO - Running setup.py install for mozscreenshot 06:42:26 INFO - Running setup.py install for moztest 06:42:26 INFO - Running setup.py install for mozversion 06:42:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:42:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:42:26 INFO - Cleaning up... 06:42:26 INFO - Return code: 0 06:42:26 INFO - Installing None 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', '-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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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', '-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:26 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: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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:26 INFO - Running setup.py (path:/tmp/pip-osBy7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:26 INFO - Running setup.py (path:/tmp/pip-V0ojTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:26 INFO - Running setup.py (path:/tmp/pip-fUj7Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:26 INFO - Running setup.py (path:/tmp/pip-UFfz_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:27 INFO - Running setup.py (path:/tmp/pip-_uC2dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:27 INFO - Running setup.py (path:/tmp/pip-6La5Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:27 INFO - Running setup.py (path:/tmp/pip-wbs5sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:27 INFO - Running setup.py (path:/tmp/pip-gkMSpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:27 INFO - Running setup.py (path:/tmp/pip-ajEVN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:27 INFO - Running setup.py (path:/tmp/pip-duMc4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:27 INFO - Running setup.py (path:/tmp/pip-rUSF7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:27 INFO - Running setup.py (path:/tmp/pip-JHD3Vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:27 INFO - Running setup.py (path:/tmp/pip-aA2jF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:27 INFO - Running setup.py (path:/tmp/pip-XFq5R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:27 INFO - Running setup.py (path:/tmp/pip-J5r6pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:27 INFO - Running setup.py (path:/tmp/pip-XFolNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:27 INFO - Running setup.py (path:/tmp/pip-4iRudn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:27 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:27 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:27 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:27 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:27 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:27 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:27 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:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:42:27 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:27 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:27 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:27 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:29 INFO - Downloading blessings-1.6.tar.gz 06:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:42:29 INFO - Installing collected packages: blessings 06:42:29 INFO - Running setup.py install for blessings 06:42:29 INFO - Successfully installed blessings 06:42:29 INFO - Cleaning up... 06:42:29 INFO - Return code: 0 06:42:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:29 INFO - Reading from file tmpfile_stdout 06:42:29 INFO - Current package versions: 06:42:29 INFO - argparse == 1.2.1 06:42:29 INFO - blessings == 1.6 06:42:29 INFO - blobuploader == 1.2.4 06:42:29 INFO - docopt == 0.6.1 06:42:29 INFO - functools32 == 3.2.3-2 06:42:29 INFO - jsonschema == 2.5.1 06:42:29 INFO - manifestparser == 1.1 06:42:29 INFO - mozInstall == 1.13 06:42:29 INFO - mozcrash == 1.0 06:42:29 INFO - mozdebug == 0.1 06:42:29 INFO - mozdevice == 0.51 06:42:29 INFO - mozfile == 1.2 06:42:29 INFO - mozhttpd == 0.7 06:42:29 INFO - mozinfo == 0.10 06:42:29 INFO - mozleak == 0.1 06:42:29 INFO - mozlog == 3.5 06:42:29 INFO - moznetwork == 0.27 06:42:29 INFO - mozprocess == 0.25 06:42:29 INFO - mozprofile == 0.28 06:42:29 INFO - mozrunner == 6.13 06:42:29 INFO - mozscreenshot == 0.1 06:42:29 INFO - mozsystemmonitor == 0.3 06:42:29 INFO - moztest == 0.8 06:42:29 INFO - mozversion == 1.4 06:42:29 INFO - psutil == 3.1.1 06:42:29 INFO - requests == 1.2.3 06:42:29 INFO - wsgiref == 0.1.2 06:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:29 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 06:42:29 INFO - 'HOME': '/home/cltbld', 06:42:29 INFO - 'LANG': 'en_US.UTF-8', 06:42:29 INFO - 'LANGUAGE': 'en_US:en', 06:42:29 INFO - 'LOGNAME': 'cltbld', 06:42:29 INFO - 'MAIL': '/var/mail/cltbld', 06:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:29 INFO - 'MOZ_NO_REMOTE': '1', 06:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:29 INFO - 'NO_EM_RESTART': '1', 06:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:29 INFO - 'PWD': '/builds/slave/test', 06:42:29 INFO - 'SHELL': '/bin/bash', 06:42:29 INFO - 'SHLVL': '1', 06:42:29 INFO - 'TERM': 'linux', 06:42:29 INFO - 'TMOUT': '86400', 06:42:29 INFO - 'USER': 'cltbld', 06:42:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 06:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:29 INFO - '_': '/tools/buildbot/bin/python'} 06:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:42:29 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:29 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:29 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:29 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:31 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:42:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:42:31 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:31 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:31 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:31 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:31 INFO - Installing collected packages: marionette-driver, simplejson 06:42:31 INFO - Running setup.py install for marionette-driver 06:42:31 INFO - Running setup.py install for simplejson 06:42:31 INFO - building 'simplejson._speedups' extension 06:42:31 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:32 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:32 INFO - Successfully installed marionette-driver simplejson 06:42:32 INFO - Cleaning up... 06:42:32 INFO - Return code: 0 06:42:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:32 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 0xbf41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf64d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, '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': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 06:42:32 INFO - 'HOME': '/home/cltbld', 06:42:32 INFO - 'LANG': 'en_US.UTF-8', 06:42:32 INFO - 'LANGUAGE': 'en_US:en', 06:42:32 INFO - 'LOGNAME': 'cltbld', 06:42:32 INFO - 'MAIL': '/var/mail/cltbld', 06:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:32 INFO - 'MOZ_NO_REMOTE': '1', 06:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:32 INFO - 'NO_EM_RESTART': '1', 06:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:32 INFO - 'PWD': '/builds/slave/test', 06:42:32 INFO - 'SHELL': '/bin/bash', 06:42:32 INFO - 'SHLVL': '1', 06:42:32 INFO - 'TERM': 'linux', 06:42:32 INFO - 'TMOUT': '86400', 06:42:32 INFO - 'USER': 'cltbld', 06:42:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 06:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:32 INFO - '_': '/tools/buildbot/bin/python'} 06:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:42:32 INFO - Cleaning up... 06:42:32 INFO - Return code: 0 06:42:32 INFO - Running post-action listener: _resource_record_post_action 06:42:32 INFO - Running post-action listener: _start_resource_monitoring 06:42:32 INFO - Starting resource monitoring. 06:42:32 INFO - [mozharness: 2017-07-27 13:42:32.746253Z] Finished create-virtualenv step (success) 06:42:32 INFO - [mozharness: 2017-07-27 13:42:32.746722Z] Running install step. 06:42:32 INFO - Running pre-action listener: _resource_record_pre_action 06:42:32 INFO - Running main action method: install 06:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:32 INFO - Reading from file tmpfile_stdout 06:42:32 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:33 INFO - Reading from file tmpfile_stdout 06:42:33 INFO - Output received: 06:42:33 INFO - Usage: mozinstall [options] installer 06:42:33 INFO - Options: 06:42:33 INFO - -h, --help show this help message and exit 06:42:33 INFO - -d DEST, --destination=DEST 06:42:33 INFO - Directory to install application into. [default: 06:42:33 INFO - "/builds/slave/test"] 06:42:33 INFO - --app=APP Application being installed. [default: firefox] 06:42:33 INFO - mkdir: /builds/slave/test/build/application 06:42:33 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:33 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:51 INFO - Reading from file tmpfile_stdout 06:42:51 INFO - Output received: 06:42:51 INFO - /builds/slave/test/build/application/firefox/firefox 06:42:51 INFO - Running post-action listener: _resource_record_post_action 06:42:51 INFO - [mozharness: 2017-07-27 13:42:51.113659Z] Finished install step (success) 06:42:51 INFO - [mozharness: 2017-07-27 13:42:51.113916Z] Running setup-mitmproxy step. 06:42:51 INFO - Running pre-action listener: _resource_record_pre_action 06:42:51 INFO - Running main action method: setup_mitmproxy 06:42:51 INFO - Skipping: mitmproxy is not required 06:42:51 INFO - Running post-action listener: _resource_record_post_action 06:42:51 INFO - [mozharness: 2017-07-27 13:42:51.115048Z] Finished setup-mitmproxy step (success) 06:42:51 INFO - [mozharness: 2017-07-27 13:42:51.115271Z] Running run-tests step. 06:42:51 INFO - Running pre-action listener: _resource_record_pre_action 06:42:51 INFO - Running pre-action listener: _set_gcov_prefix 06:42:51 INFO - Running main action method: run_tests 06:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:51 INFO - Python 2.7.3 06:42:51 INFO - Return code: 0 06:42:51 INFO - grabbing minidump binary from tooltool 06:42:51 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:51 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 0xf61eb0>, '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 0xf62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf63240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:51 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:51 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:51 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:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:51 INFO - Return code: 0 06:42:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:42:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:51 INFO - ENV: RUST_BACKTRACE is now 1 06:42:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:42:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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:51 INFO - Using env: {'DISPLAY': ':0', 06:42:51 INFO - 'HOME': '/home/cltbld', 06:42:51 INFO - 'LANG': 'en_US.UTF-8', 06:42:51 INFO - 'LANGUAGE': 'en_US:en', 06:42:51 INFO - 'LOGNAME': 'cltbld', 06:42:51 INFO - 'MAIL': '/var/mail/cltbld', 06:42:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:51 INFO - 'MOZ_NO_REMOTE': '1', 06:42:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:51 INFO - 'NO_EM_RESTART': '1', 06:42:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:51 INFO - 'PWD': '/builds/slave/test', 06:42:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:51 INFO - 'RUST_BACKTRACE': '1', 06:42:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:42:51 INFO - 'SHELL': '/bin/bash', 06:42:51 INFO - 'SHLVL': '1', 06:42:51 INFO - 'TERM': 'linux', 06:42:51 INFO - 'TMOUT': '86400', 06:42:51 INFO - 'USER': 'cltbld', 06:42:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884', 06:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:51 INFO - '_': '/tools/buildbot/bin/python'} 06:42:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:51 INFO - mozversion application_buildid: 20170727125647 06:42:51 INFO - mozversion application_changeset: 658cba6a971257e2ba39715ec938256dfc414776 06:42:51 INFO - mozversion application_display_name: Nightly 06:42:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:51 INFO - mozversion application_name: Firefox 06:42:51 INFO - mozversion application_remotingname: firefox 06:42:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:42:51 INFO - mozversion application_vendor: Mozilla 06:42:51 INFO - mozversion application_version: 56.0a1 06:42:51 INFO - mozversion platform_buildid: 20170727125647 06:42:51 INFO - mozversion platform_changeset: 658cba6a971257e2ba39715ec938256dfc414776 06:42:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:42:51 INFO - mozversion platform_version: 56.0a1 06:42:51 INFO - using testdate: 1501162971 06:42:51 INFO - actual date: 1501162971 06:42:51 INFO - starting webserver on 'localhost:54396' 06:42:51 INFO - SUITE-START | Running 2 tests 06:42:51 INFO - TEST-START | dromaeo_css 06:42:51 INFO - Initialising browser for dromaeo_css test... 06:42:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54396/getInfo.html -profile /tmp/tmpSaw6Az/profile 06:42:51 INFO - TEST-INFO | started process 27043 (/builds/slave/test/build/application/firefox/firefox http://localhost:54396/getInfo.html) 06:42:57 INFO - TEST-INFO | 27043: exit 0 06:42:57 INFO - Browser initialized. 06:42:57 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:57 INFO - TEST-INFO | started process 27253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSaw6Az/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:58 INFO - PID 27253 | 06:42:58 INFO - PID 27253 | (/builds/slave/test/build/application/firefox/firefox:27301): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:42:58 INFO - PID 27253 | 06:43:09 INFO - PID 27253 | RSS: Main: 171196416 06:43:09 INFO - PID 27253 | 06:46:07 INFO - PID 27253 | Cycle 1(1): loaded http://localhost:54396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54396/tests/dromaeo/cssquery-ext.html) 06:46:09 INFO - PID 27253 | RSS: Main: 173051904 06:46:09 INFO - PID 27253 | 06:49:11 INFO - PID 27253 | Cycle 1(1): loaded http://localhost:54396/tests/dromaeo/cssquery-ext.html (next: http://localhost:54396/tests/dromaeo/cssquery-jquery.html) 06:49:12 INFO - PID 27253 | RSS: Main: 170373120 06:49:12 INFO - PID 27253 | 06:52:14 INFO - PID 27253 | Cycle 1(1): loaded http://localhost:54396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54396/tests/dromaeo/cssquery-mootools.html) 06:52:14 INFO - PID 27253 | RSS: Main: 172879872 06:52:14 INFO - PID 27253 | 06:55:16 INFO - PID 27253 | Cycle 1(1): loaded http://localhost:54396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54396/tests/dromaeo/cssquery-prototype.html) 06:55:16 INFO - PID 27253 | RSS: Main: 170823680 06:55:16 INFO - PID 27253 | 06:58:20 INFO - PID 27253 | Cycle 1(1): loaded http://localhost:54396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54396/tests/dromaeo/cssquery-yui.html) 06:58:21 INFO - PID 27253 | RSS: Main: 172593152 06:58:21 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | Cycle 1(1): loaded http://localhost:54396/tests/dromaeo/cssquery-yui.html (next: http://localhost:54396/tests/dromaeo/cssquery-dojo.html) 07:01:23 INFO - PID 27253 | RSS: Main: 174596096 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | __start_tp_report 07:01:23 INFO - PID 27253 | _x_x_mozilla_page_load 07:01:23 INFO - PID 27253 | _x_x_mozilla_page_load_details 07:01:23 INFO - PID 27253 | |i|pagename|runs| 07:01:23 INFO - PID 27253 | |0;dojo.html;3055.4194703006415;3117.9532307015393;3135.404273188094;3161.7786754927156;3176.4600017996936;6056.727447264872;6104.023356262999;6153.630782153074;6191;6209.379062093794;6202.906956395657;6232.750689972396;6243.344448832875;6275.3410891856265;6299.433051025407;5539.944600554003;5649.23735295736;5693.146028095788;5739.053056245714;5801.970990145043;5630.774769009235;5662.631928924628;5722.599418040739;5737.282839645044;5749.856253593652;5650.180723795027;5670.37625861157;5719.999000174974;5747.33905600855;5758.193852860602;5626.774929002835;5678.403767604384;5729.28383952006;5741.33974592923;5745.540356771448;5508.724563771835;5613.607047506676;5624.775008999635;5640.097584386478;5678.829635110953;6070.484008859252;6161.599496032743;6164.6917654117115;6172.537059720539;6176.536759742992;6620.768273110418;6644.767433139865;6772.11962444879;6773.254941956381;6783.321667833177;6638.701258443333;6695.196576410862;6703.631300278483;6728.360805723449;6734.629595372253;6199.473044791198;6234.0960560718895;6250.6874656267;6269.5611307208055;6279.340669229757;6861.416779573692;6895.75864844728;6956.0609317741455;6969.686364113627;6981.441484681213;6376.808695739135;6555.115059466911;6556.606603603799;6560.671966401661;6570.671466426659;6648.601083934979;6670.7665231716655;6677.799666010027;6678.432333251631;6682.064510968468;6640;6641.701123449457;6659.101021362151;6667.733290668416;6682.5322227444585;6622.072909792633;6652.634105124264;6687.1975362956755;6743.1908171019795;6756.121704178524;5358.651687640291;5382.91925621116;5446.074167391553;5457.072297709399;5458.2904222451625;4524.683272170916;4560.201964656172;4574.862754117382;4592.035672508744;4664.160451118832;5785.623934444247;5793.449622285876;5813.04084825999;5817.50551203144;5823.650580965155;6582.012698095324;6652.534322597372;6658.300878407795;6659.933400666028;6663.4669226461765;5756.884862302731;5778.8266352009505;5856.092305692625;5859.296884373903;5867.031939729897;5812.070068788974;5850.736716847752;5882.676452795137;5961.135635332853;5963.701814909324;6424.16485856845;6443.645599491979;6449.451796597342;6453.741850326029;6456.967715161488;6643.534952553468;6648.867022659617;6734.932650673627;6739.292374300628;6744.494162937701;6536.869262614626;6566.343365663395;6575.079488871466;6582.572132811352;6590.1103351046995;6541.901871471837;6565.835854103495;6644.83387915306;6659.367360100783;6670.799876003728;6618.470522358296;6685.832854178684;6698.966505167443;6748.527603067738;6797.592144471348;6422.710978005907;6497.4477169441125;6499.025146228104;6510.0885875976455;6545.967270163619;6530.608163510205;6548.8035358939305;6553.967230163818;6558.278589355263;6567.770128045496;6450.774222902176;6471.514636402195;6482.384173503509;6497.317781632861;6500.057491663588;6536.6731663415685;6538.313477084837;6590.176227971504;6628.403443690091;6637.966810165918;6240.656763878031;6296.496280297473;6322.557420980671;6328.46208072319;6404.967975160281 07:01:23 INFO - PID 27253 | |1;ext.html;829.593499185399;834.4659417972495;851.5742128935532;881.9250363719084;885.7342797160854;41973.79013104934;42519;42818.785906070465;42837.35743963843;42858.7857060715;37497.50009999597;37805.43291850617;37807.43288850669;37812.81093594535;37876.81061594695;6968.756093536727;7084.114485689289;7104.85790284194;7114.822129446753;7132.215456299803;6993.685284162199;6994.020837082812;7030.543014704053;7086.9645651771925;7089.680964356617;7101.289871012909;7404.4816862819625;7975.7607271781935;7998.600069996506;8005.67977280911;7945.682172713085;7963.283304502623;7974.5215287082965;7980.401469889782;7981.521108733495;7678.078630564312;7744.186860379636;7798.688052477894;7840.255175758294;7848.175941526171;39508.802455987825;39808;39826.40260396097;39986.80006599949;40031.39952900709;3450.7929524228625;3508.0703613542432;3508.771929824579;3509.438489841639;3517.296540691872;31699;32044.519332210035;32063;32153.1961700957;32305.6769432305;4679.81280748773;4734.147853386389;4753.548412900769;4789.042191561667;4796.112719146934;180711;181924;189306.99999999863;193440;197671.01164494228;48063.75968120137;48080;48225.75887120612;48270;48300.5169948296;50320;50497;50521.74739126281;50650.746746266035;50691.47925562239;16386.508404747878;16412.09733464647;16463.83536164623;16521.33914643425;16647.667046659;13738.793918091036;13864.168149911038;13881.375338109809;13885.305734713224;13890.58328250154;13712;13825.170489770646;13846.307684615931;14044.368003439666;14127.929360353133;5448;5479.561635069185;5485.122380419114;5511.311086114236;5534.695591742493;886.8913857677902;912.5619702542684;921.3872774604947;939.112538650982;969.4813274897896;20829.854358010456;21341.78658213429;21719;28901;28919.71080289212;1043.5564884923876;1061.697416236369;1080.9297395669257;1095.424901926479;1097.160672085855;11652.184347095792;11775.17573769845;11780.352080635646;11872.10959178065;11963.700907477209;235169;237274;237516;237832;238540;52687;52813;53127.20309195365;53163;53206.20190697143;1391.3530208452914;1469.441612187362;1474.7492926202572;1477.682298305848;1502.6318551954841;20852.77345774979;21273.7872621278;21618.89190554037;21967.23114690978;22187.1125154992;37189.25621487501;37279;37316.81341593383;37408.81295593613;37424.438633421065;195689;197056;197227;197518;197822;32032.5195122078;33331.83334083314;33630.159246019044;33817.3236535263;33822.66177338195;43115.7844210777;43202;43567.56432435762;43718;43753.56246437495;28163.859180704785;30244;30681.8465907669;30751.692483074883;30854.691453085183;29002.7099729;29148.708512915447;29998.85000574983;30115.849420752755;30215.546766798954;38841.41737873878;38859.805700971316;39120.21759564849;39487.80256098701;39542.60457395389;31368.37263254768;32699;33050;33552.49671254884;33987.83006084954;24255.272341829772;24320.51358972846;24396.26811195667;24585.262442126765;24748.257552273462 07:01:23 INFO - PID 27253 | |2;jquery.html;581.6016029020121;585.3941170888131;588.1912370490576;588.2617315269333;592.386879579635;22207.44481387966;22483.887580562114;23019.194328198515;23022.53954920903;23043.42391440215;24353.904074316655;25892.22323330303;26020.21939341818;26029.60955585663;26110.869445652792;6442.194725659293;6612.834679133012;6620.801375958705;6623.867522649544;6631.137952066225;6108.969455152718;6493.70778314977;6551.181102362205;6556.016597510364;6597.505187110962;6521.543491955541;6552.049952756847;6554.279029306773;6554.639494827807;6569.441597464197;6495.740170393178;6527.118838956728;6543.149390579242;6573.605583664996;6583.374579414948;6106.847328816771;6114;6116.143739876421;6119.5410344224365;6119.755209791648;28543.000994965078;29694.851525742448;29829;29897.850510747525;30072.248193795112;1867.4491025147613;1909.026396537762;1909.1981367825547;1911.4838993471685;1913.6651086059883;18704.906475467535;19250.22999080035;19253.32613358526;19257.518562035923;19266;2329.743728189898;2333.4866329407505;2342;2399.1722855614785;2399.376162197841;127841;129452;130855;134423;134508.6549134506;14066.648333791532;14503.709925801424;14727.484538041117;15082.924585377003;15118;23316.65025024626;23475.295741127793;23538.29385118449;23546;23551.882240588686;9937.552810123561;10159;10269.589216431408;10296.382217067;10461.424621645883;9563.09150630689;9624.51877406127;9628.66299679508;9705.223582113415;9818.852717209247;7736.497127686683;8853.51305678194;8964.14840590143;8995.820083598423;9127.771805704777;2623.5933430318332;2681.6781986161786;2688.4354285600243;2688.4623075385;2784.763295119897;923.3075193604797;930.8324501589643;934.672864497434;963.9566219519999;973.2505970402892;18897.24411023571;19307.131179096974;19447.513812154528;19853.30513432052;22990.885045574665;988.2242439684813;989.2580564576567;1016.4917541229386;1018.5314755212537;1030.3663247103127;10740.462976851282;11134.665960021212;11369.431528423711;11369.602063927889;11529.596464123715;541692;550624;551675;558083;564100;119563;120247;120766;121909.39045304716;122196.38901805434;1249.1693024138847;1265.1270623269913;1289.6002239305844;1290.2452065541763;1296.500847173845;17091.48725538236;17773.46679599614;17941.102944852442;18444.907775461037;18620;54662.72668636632;55880.441195587526;58278;58529;59736.70131649314;72701.6364918172;73022;73046.26953730395;74482;74591.62704186444;12416.130870838955;12875.678108047374;14518.346674399467;14803.111813291236;14823.40706371733;23413.53172936566;24088.397790055387;24147.637785433584;24437.26688199286;24898.626520601843;18980.905095474987;19092.8090719091;19205.32781352646;19231.230750770374;19306.32427865018;15501.147436890627;16885.24016419289;17059;17340.566485837953;17393.478195654152;19443;19638;19748.321392681784;19835.30576429818;19996;14817.33322000491;15008.699826003638;15036.849631503545;15053.397864085751;15162.772558411853;17631.559211019827;17972.730409044136;18718;19129.808701912803;19327.710084348466 07:01:23 INFO - PID 27253 | |3;mootools.html;1371.2800779590714;1418.9006769526138;1420.1337184317567;1422.5021242565097;1423.9715205695886;13458.932705336472;13914.860851391482;13923.443062277509;13971.860281397183;13982.720345593081;11774.529018839236;12155.513779448811;13573.932130339359;13955.79066314006;13961.09252898561;2524.3941454050987;2579.8581078040793;2588.4564241509306;2589.9870500647567;2595.3511622094475;2461.6307553866886;2506.373406648338;2573.6010918307597;2577.30412788547;2583.289595361272;2629.106103924665;2636.5122452346377;2646.748558886912;2652.071774878796;2654.3496843273424;2470.703515578124;2497.051120574179;2507.135038411745;2511.1462102885107;2512.321673148249;2410.927672169838;2431.1004928176512;2451.7793398594213;2458.606622940321;2458.704955405345;13223.338833058404;13404.664883377896;13450.192988420726;13459.394327255297;13469.797953030713;7353.338199562065;7505.136909255396;7579.204183560757;7633.465657403984;7649.426293027989;4697;4822.590079843218;4891.192953162724;4950.653454258203;4993.775280112403;1858.7676540432446;1869.3270422647836;1891.5176629959271;1900.3253844885144;1913.8373238274764;20954.790452095436;21078.78921210799;21131.47171320714;21198.152073917026;21220.575588488144;5999.910001349983;6070.453659170696;6202.875942481125;6210.472109870621;6272.498200143978;14781.408743650349;14819.333130009176;14881.404743810126;14919.776203356958;14952.401903923721;7045.68294426752;7142.642867856586;7143;7160.319769621878;7164;6249.718762655601;6608.339166083353;6611.735530578723;6616.536842420985;6670.366315200048;4973.254011898244;5179.689218646893;5188.92216616751;5195.896082078338;5223;1388.7361401333715;1456.2427537680346;1485.7994170787022;1489.9553013409616;1515.886308526865;759.8936148939152;765.0780809124991;788.7200043984418;805.6133056133089;810.9310708589718;6924.23833378328;6989;7150.5352152109945;7172.856542869114;7242.9275707243305;890.692711014699;916.1525588830439;938.3900464697864;947.7867479816986;950.9191718703987;3946.092398748304;4245.3631955206965;4488.4165058542185;4546.704464209815;4546.818127274872;18253.17860696272;18838.15228314729;19047;19405.320813771734;19448.611027779367;18857.810253953143;19274.32539861098;19424.902875485815;19464.8053519463;19506.31727889517;10679.83980240297;10701.678949631523;10777.35335879834;10843.07833834117;10912.454377281105;6752.93247067523;6986.336298051677;7094.822629434306;7230.168530619047;7273.927260727537;15786.60533486626;16718.49844504667;17070.914645426692;17077.91461042687;17401.56496087608;17199;17258.13709314504;17361.045142516778;17432.21555030052;17512.91243543774;10476.895231047592;10579;10582.365058096231;10583.470826458492;10583.4708264588;12761.234325940473;12860.935695321463;12892.41984110736;12949.805752913902;13119.147255428366;9618;10062.295639305179;10138.03688649577;10262.332948358333;10274.434906080238;9875.753106172404;10176.949115254376;10332.17342612574;10361.119304859172;10628.468576570986;8514;8710.695125670825;8716.215540601377;8718.60766265507;8746.956265218887;6400.743970241325;6479.157709497735;6527.67361631926;6630.7679231226675;6707.731690732316;6183.84540386494;6237.5321850860455;6249.906251406142;6413.927156255718;6466.418022378009 07:01:23 INFO - PID 27253 | |4;prototype.html;476.14769562483156;499.022583718897;511.7390131033174;512.7718165416392;514.3955851874048;6129.927262729021;6155.060761112885;6202.3487533808975;6205.441510264075;6250.374962503759;5853.707314634273;5953.404659534044;6004.609700369473;6029.216201893759;6067.453929146376;4764.523547645243;4793.13067903517;4828.61371090312;4843.200871856139;4879.951200487985;4676.719396836201;4829.22732362822;4836.733979631119;4843.4187897452175;4849.720631303282;4716.98584804267;4792.688475249115;4813.90372192556;4834.854954351375;4887.169181239198;4774.236122220445;4818.494058123882;4822.228443449031;4864.878378040542;4869.836289972059;4305.289627211507;4336.349547567858;4346.326319420495;4372.628326592244;4390.517043125254;5916.615419997686;5935.6438613682885;5969.835882003011;6005.399460054004;6011.158437818709;5515.944840551583;5534.695591742493;5608.971955140199;5609;5641.8589535261535;6420.683759829224;6425;6449.419552240274;6494.188226471691;6523.347665233486;4747.477777444478;4762.547557981986;4775.14047471455;4785.162596545625;4792.041591681643;6766.864662706718;6846.760363387308;6876;6881.621510816903;6915.654217289115;4857.149998750205;4868.95131048685;4889.926651100236;4906.239532872411;4910.680805747615;4959.7272150032095;4970.850874473772;4977.800887964441;4995.701117709422;4996.525330093708;5566.721663916788;5588.30146231721;5603.299587551556;5626.521745651584;5642.266505354278;6424.935750642434;6450.322716114741;6473.417392434703;6482.740690372332;6577.375149360803;1626.7071927053244;1656.724322271844;1658.552190908448;1663.20166320167;1721.28566644841;1170.12825445044;1186.9940650296694;1195.9162858599814;1200.7178313096415;1204.3978010994504;5629.296337957755;5639.689817060101;5689.487946084872;5696.458836410535;5708.343540492813;6367.713452894631;6570.653016131681;6575.210974683068;6596.175478065242;6652.268250492442;5662.462066103713;5721.342045664718;5724.542036637059;5758.7696492140685;5761.48146666802;3448.3620530201993;3474.756767026284;3505.5618047744033;3531.205478767257;3535.292941411728;6404.327545607644;6423;6473.385028422293;6501.47988160946;6511.186101737283;6783.389494945479;6807.625580593115;6831.897521537181;6884.724611015503;6914.481413893877;6401.167848179707;6417.9679101605125;6485;6489.67551622417;6490.545661803629;6546.149000629887;6565.901511477427;6680.298568650416;6699.263081061177;6709.429698475489;6584.2551723794195;6615.4784399589325;6652.501062420434;6670.83322916931;6689.7289514992;6421.967890160519;6429.292777794345;6451.806445806634;6454.160959075478;6497.447716943923;4862.246351815475;4863.635227357891;4903.215485522299;4909.656324057281;4914.778834952364;6399.936000639934;6657.201135863727;6754.290799466182;6795.830104247433;6814.250432452327;6254.906176407267;6257.249130104235;6318.810435686937;6493.837654058686;6545.607263564201;6409.8718025640155;6412.35876412355;6461.512317757791;6479.481641468766;6517.446017088411;6418.967905160444;6428;6432.388923052303;6462.321456247027;6481.4814814815645;6434.292227855026;6505.154329937078;6510.576812507172;6574.178227721535;6606;6275.874482510233;6286.74853005893;6311.431971122621;6313.600831683931;6356.745730170926 07:01:23 INFO - PID 27253 | |5;yui.html;897.3628723606239;906.6781292641112;912.2291663544311;924.3668087360156;927.0960813207124;18219.18013689384;19145.42563723087;19252.614947701037;19287.421377358703;19305;19676.606467870668;21351.466213344673;21389;21503.354899353006;21689.457763555918;971.7619183300084;988.8368419210822;990.7027891632481;991.2565575818137;992.4541502173776;1003.5684655598089;1045.2056437107776;1048.8164571200048;1050.2228351020267;1057.8360354145082;1089.4008295437518;1098.505672447398;1102.079763397564;1102.4322473925895;1111.5053801058532;1088.031651829872;1090.4820210400076;1094.6278265389726;1101.752105776202;1103.2112039891476;795.3637090327715;796.9003874515686;798.700487317256;800.5716941436361;806.0931452116369;18119.094045297814;18586.16362263688;18754;19098.52253693669;19123.139458724392;19441.22235110594;19576.902115489473;19854.00729963496;19908.104135313944;20429.69355459669;15035.097894126278;15246.085234885943;15379.615509612237;15542.456014039455;15688.921555392264;3018.9698103019127;3092.1805721483825;3095.5666206731075;3102.860371283298;3105.1616063662686;115429.42285288604;117747;122473;123973;126491;15510.767338489932;15513.534593962198;15829.920850395674;15914.840851591336;15921.203939802963;26459.338516537242;29912.40175196484;30132.84933575318;30178.24554386114;30240.69759302379;8283.544405057779;8393.748187554384;8400.705975290835;8436.915630843612;8498.107698691672;4068.349064149722;4148.481439820022;4152.065785198306;4155.252054630135;4156.56356082613;4707.952920470751;4913.70517768935;5557.749901254453;5658.632188907708;5677.858053548612;1073.3238060022136;1092.5575142067476;1104.6023431564631;1105.8396532502902;1112.0436424674774;643.8905386084377;655.7999810057883;666.3702800853147;674.3223060823939;681.9454443644596;11365.943170284096;11518.078553715683;11996.820047699117;12000.63998080059;13030.609081727564;660.7522179182806;669.1401549009597;675.3280485916545;675.4630069094983;679.972801087951;4910.459849416561;5289.471052894757;5333.093464062095;5456.836294911159;5499.862503437446;101935;103706.4814675937;107408.46295768471;107759.46120269349;107981;86024.5698771502;91660.54169729109;92764;93907.53046234862;93944;74777;75287.22460814839;77456;77664;79204;10219.386836789816;10250.743731406475;10455.320404173704;10703;10759.08547773448;34944.475832862016;35319.470207947415;35381.82309088438;36039;37798.43302350522;43956;65544.34455655383;67551;69363.30636693568;71452.64273678807;18389.448316550526;18679.906600467453;18830.435086947415;19164.8083519163;19191.424257271745;17138.314467421664;20260.696089558372;20429;20650.690239646116;20829.89585052065;18709.812901870806;19060.1422935971;19235.807641923402;19292;19587.60824783468;18094.457166285032;18468;18933.33733319327;19294.421167365002;19512.21951121939;16130.193490325672;16278.43025494102;16295;18420.355287565406;18703.1583578742;12346;12510.374481276081;12684.365781710692;12690.492380304684;12995.545155919875;13234.933825330812;13239;13540.79688804649;13571.52499662507;13773.38019789132 07:01:23 INFO - PID 27253 | __end_tp_report 07:01:23 INFO - PID 27253 | __start_cc_report 07:01:23 INFO - PID 27253 | _x_x_mozilla_cycle_collect,376 07:01:23 INFO - PID 27253 | __end_cc_report 07:01:23 INFO - PID 27253 | __startTimestamp1501164083330__endTimestamp 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | ------- Summary: start ------- 07:01:23 INFO - PID 27253 | Number of tests: 6 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | [#0] dojo.html Cycles:165 Average:6147.78 Median:6424.16 stddev:735.50 (11.4%) stddev-sans-first:696.61 07:01:23 INFO - PID 27253 | Values: 3055.4 3118.0 3135.4 3161.8 3176.5 6056.7 6104.0 6153.6 6191.0 6209.4 6202.9 6232.8 6243.3 6275.3 6299.4 5539.9 5649.2 5693.1 5739.1 5802.0 5630.8 5662.6 5722.6 5737.3 5749.9 5650.2 5670.4 5720.0 5747.3 5758.2 5626.8 5678.4 5729.3 5741.3 5745.5 5508.7 5613.6 5624.8 5640.1 5678.8 6070.5 6161.6 6164.7 6172.5 6176.5 6620.8 6644.8 6772.1 6773.3 6783.3 6638.7 6695.2 6703.6 6728.4 6734.6 6199.5 6234.1 6250.7 6269.6 6279.3 6861.4 6895.8 6956.1 6969.7 6981.4 6376.8 6555.1 6556.6 6560.7 6570.7 6648.6 6670.8 6677.8 6678.4 6682.1 6640.0 6641.7 6659.1 6667.7 6682.5 6622.1 6652.6 6687.2 6743.2 6756.1 5358.7 5382.9 5446.1 5457.1 5458.3 4524.7 4560.2 4574.9 4592.0 4664.2 5785.6 5793.4 5813.0 5817.5 5823.7 6582.0 6652.5 6658.3 6659.9 6663.5 5756.9 5778.8 5856.1 5859.3 5867.0 5812.1 5850.7 5882.7 5961.1 5963.7 6424.2 6443.6 6449.5 6453.7 6457.0 6643.5 6648.9 6734.9 6739.3 6744.5 6536.9 6566.3 6575.1 6582.6 6590.1 6541.9 6565.8 6644.8 6659.4 6670.8 6618.5 6685.8 6699.0 6748.5 6797.6 6422.7 6497.4 6499.0 6510.1 6546.0 6530.6 6548.8 6554.0 6558.3 6567.8 6450.8 6471.5 6482.4 6497.3 6500.1 6536.7 6538.3 6590.2 6628.4 6638.0 6240.7 6296.5 6322.6 6328.5 6405.0 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | [#1] ext.html Cycles:180 Average:37640.03 Median:37234.13 stddev:54133.38 (145.4%) stddev-sans-first:54214.67 07:01:23 INFO - PID 27253 | Values: 829.6 834.5 851.6 881.9 885.7 41973.8 42519.0 42818.8 42837.4 42858.8 37497.5 37805.4 37807.4 37812.8 37876.8 6968.8 7084.1 7104.9 7114.8 7132.2 6993.7 6994.0 7030.5 7087.0 7089.7 7101.3 7404.5 7975.8 7998.6 8005.7 7945.7 7963.3 7974.5 7980.4 7981.5 7678.1 7744.2 7798.7 7840.3 7848.2 39508.8 39808.0 39826.4 39986.8 40031.4 3450.8 3508.1 3508.8 3509.4 3517.3 31699.0 32044.5 32063.0 32153.2 32305.7 4679.8 4734.1 4753.5 4789.0 4796.1 180711.0 181924.0 189307.0 193440.0 197671.0 48063.8 48080.0 48225.8 48270.0 48300.5 50320.0 50497.0 50521.7 50650.7 50691.5 16386.5 16412.1 16463.8 16521.3 16647.7 13738.8 13864.2 13881.4 13885.3 13890.6 13712.0 13825.2 13846.3 14044.4 14127.9 5448.0 5479.6 5485.1 5511.3 5534.7 886.9 912.6 921.4 939.1 969.5 20829.9 21341.8 21719.0 28901.0 28919.7 1043.6 1061.7 1080.9 1095.4 1097.2 11652.2 11775.2 11780.4 11872.1 11963.7 235169.0 237274.0 237516.0 237832.0 238540.0 52687.0 52813.0 53127.2 53163.0 53206.2 1391.4 1469.4 1474.7 1477.7 1502.6 20852.8 21273.8 21618.9 21967.2 22187.1 37189.3 37279.0 37316.8 37408.8 37424.4 195689.0 197056.0 197227.0 197518.0 197822.0 32032.5 33331.8 33630.2 33817.3 33822.7 43115.8 43202.0 43567.6 43718.0 43753.6 28163.9 30244.0 30681.8 30751.7 30854.7 29002.7 29148.7 29998.9 30115.8 30215.5 38841.4 38859.8 39120.2 39487.8 39542.6 31368.4 32699.0 33050.0 33552.5 33987.8 24255.3 24320.5 24396.3 24585.3 24748.3 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | [#2] jquery.html Cycles:180 Average:36675.01 Median:12877.77 stddev:92340.64 (717.1%) stddev-sans-first:92559.92 07:01:23 INFO - PID 27253 | Values: 581.6 585.4 588.2 588.3 592.4 22207.4 22483.9 23019.2 23022.5 23043.4 24353.9 25892.2 26020.2 26029.6 26110.9 6442.2 6612.8 6620.8 6623.9 6631.1 6109.0 6493.7 6551.2 6556.0 6597.5 6521.5 6552.0 6554.3 6554.6 6569.4 6495.7 6527.1 6543.1 6573.6 6583.4 6106.8 6114.0 6116.1 6119.5 6119.8 28543.0 29694.9 29829.0 29897.9 30072.2 1867.4 1909.0 1909.2 1911.5 1913.7 18704.9 19250.2 19253.3 19257.5 19266.0 2329.7 2333.5 2342.0 2399.2 2399.4 127841.0 129452.0 130855.0 134423.0 134508.7 14066.6 14503.7 14727.5 15082.9 15118.0 23316.7 23475.3 23538.3 23546.0 23551.9 9937.6 10159.0 10269.6 10296.4 10461.4 9563.1 9624.5 9628.7 9705.2 9818.9 7736.5 8853.5 8964.1 8995.8 9127.8 2623.6 2681.7 2688.4 2688.5 2784.8 923.3 930.8 934.7 964.0 973.3 18897.2 19307.1 19447.5 19853.3 22990.9 988.2 989.3 1016.5 1018.5 1030.4 10740.5 11134.7 11369.4 11369.6 11529.6 541692.0 550624.0 551675.0 558083.0 564100.0 119563.0 120247.0 120766.0 121909.4 122196.4 1249.2 1265.1 1289.6 1290.2 1296.5 17091.5 17773.5 17941.1 18444.9 18620.0 54662.7 55880.4 58278.0 58529.0 59736.7 72701.6 73022.0 73046.3 74482.0 74591.6 12416.1 12875.7 14518.3 14803.1 14823.4 23413.5 24088.4 24147.6 24437.3 24898.6 18980.9 19092.8 19205.3 19231.2 19306.3 15501.1 16885.2 17059.0 17340.6 17393.5 19443.0 19638.0 19748.3 19835.3 19996.0 14817.3 15008.7 15036.8 15053.4 15162.8 17631.6 17972.7 18718.0 19129.8 19327.7 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | [#3] mootools.html Cycles:180 Average:8334.45 Median:2501.71 stddev:5759.39 (230.2%) stddev-sans-first:5751.78 07:01:23 INFO - PID 27253 | Values: 1371.3 1418.9 1420.1 1422.5 1424.0 13458.9 13914.9 13923.4 13971.9 13982.7 11774.5 12155.5 13573.9 13955.8 13961.1 2524.4 2579.9 2588.5 2590.0 2595.4 2461.6 2506.4 2573.6 2577.3 2583.3 2629.1 2636.5 2646.7 2652.1 2654.3 2470.7 2497.1 2507.1 2511.1 2512.3 2410.9 2431.1 2451.8 2458.6 2458.7 13223.3 13404.7 13450.2 13459.4 13469.8 7353.3 7505.1 7579.2 7633.5 7649.4 4697.0 4822.6 4891.2 4950.7 4993.8 1858.8 1869.3 1891.5 1900.3 1913.8 20954.8 21078.8 21131.5 21198.2 21220.6 5999.9 6070.5 6202.9 6210.5 6272.5 14781.4 14819.3 14881.4 14919.8 14952.4 7045.7 7142.6 7143.0 7160.3 7164.0 6249.7 6608.3 6611.7 6616.5 6670.4 4973.3 5179.7 5188.9 5195.9 5223.0 1388.7 1456.2 1485.8 1490.0 1515.9 759.9 765.1 788.7 805.6 810.9 6924.2 6989.0 7150.5 7172.9 7242.9 890.7 916.2 938.4 947.8 950.9 3946.1 4245.4 4488.4 4546.7 4546.8 18253.2 18838.2 19047.0 19405.3 19448.6 18857.8 19274.3 19424.9 19464.8 19506.3 10679.8 10701.7 10777.4 10843.1 10912.5 6752.9 6986.3 7094.8 7230.2 7273.9 15786.6 16718.5 17070.9 17077.9 17401.6 17199.0 17258.1 17361.0 17432.2 17512.9 10476.9 10579.0 10582.4 10583.5 10583.5 12761.2 12860.9 12892.4 12949.8 13119.1 9618.0 10062.3 10138.0 10262.3 10274.4 9875.8 10176.9 10332.2 10361.1 10628.5 8514.0 8710.7 8716.2 8718.6 8747.0 6400.7 6479.2 6527.7 6630.8 6707.7 6183.8 6237.5 6249.9 6413.9 6466.4 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | [#4] prototype.html Cycles:180 Average:5427.13 Median:6005.00 stddev:1546.24 (25.7%) stddev-sans-first:1505.26 07:01:23 INFO - PID 27253 | Values: 476.1 499.0 511.7 512.8 514.4 6129.9 6155.1 6202.3 6205.4 6250.4 5853.7 5953.4 6004.6 6029.2 6067.5 4764.5 4793.1 4828.6 4843.2 4880.0 4676.7 4829.2 4836.7 4843.4 4849.7 4717.0 4792.7 4813.9 4834.9 4887.2 4774.2 4818.5 4822.2 4864.9 4869.8 4305.3 4336.3 4346.3 4372.6 4390.5 5916.6 5935.6 5969.8 6005.4 6011.2 5515.9 5534.7 5609.0 5609.0 5641.9 6420.7 6425.0 6449.4 6494.2 6523.3 4747.5 4762.5 4775.1 4785.2 4792.0 6766.9 6846.8 6876.0 6881.6 6915.7 4857.1 4869.0 4889.9 4906.2 4910.7 4959.7 4970.9 4977.8 4995.7 4996.5 5566.7 5588.3 5603.3 5626.5 5642.3 6424.9 6450.3 6473.4 6482.7 6577.4 1626.7 1656.7 1658.6 1663.2 1721.3 1170.1 1187.0 1195.9 1200.7 1204.4 5629.3 5639.7 5689.5 5696.5 5708.3 6367.7 6570.7 6575.2 6596.2 6652.3 5662.5 5721.3 5724.5 5758.8 5761.5 3448.4 3474.8 3505.6 3531.2 3535.3 6404.3 6423.0 6473.4 6501.5 6511.2 6783.4 6807.6 6831.9 6884.7 6914.5 6401.2 6418.0 6485.0 6489.7 6490.5 6546.1 6565.9 6680.3 6699.3 6709.4 6584.3 6615.5 6652.5 6670.8 6689.7 6422.0 6429.3 6451.8 6454.2 6497.4 4862.2 4863.6 4903.2 4909.7 4914.8 6399.9 6657.2 6754.3 6795.8 6814.3 6254.9 6257.2 6318.8 6493.8 6545.6 6409.9 6412.4 6461.5 6479.5 6517.4 6419.0 6428.0 6432.4 6462.3 6481.5 6434.3 6505.2 6510.6 6574.2 6606.0 6275.9 6286.7 6311.4 6313.6 6356.7 07:01:23 INFO - PID 27253 | 07:01:23 INFO - PID 27253 | [#5] yui.html Cycles:180 Average:22536.66 Median:19544.56 stddev:30271.13 (154.9%) stddev-sans-first:30312.44 07:01:23 INFO - PID 27253 | Values: 897.4 906.7 912.2 924.4 927.1 18219.2 19145.4 19252.6 19287.4 19305.0 19676.6 21351.5 21389.0 21503.4 21689.5 971.8 988.8 990.7 991.3 992.5 1003.6 1045.2 1048.8 1050.2 1057.8 1089.4 1098.5 1102.1 1102.4 1111.5 1088.0 1090.5 1094.6 1101.8 1103.2 795.4 796.9 798.7 800.6 806.1 18119.1 18586.2 18754.0 19098.5 19123.1 19441.2 19576.9 19854.0 19908.1 20429.7 15035.1 15246.1 15379.6 15542.5 15688.9 3019.0 3092.2 3095.6 3102.9 3105.2 115429.4 117747.0 122473.0 123973.0 126491.0 15510.8 15513.5 15829.9 15914.8 15921.2 26459.3 29912.4 30132.8 30178.2 30240.7 8283.5 8393.7 8400.7 8436.9 8498.1 4068.3 4148.5 4152.1 4155.3 4156.6 4708.0 4913.7 5557.7 5658.6 5677.9 1073.3 1092.6 1104.6 1105.8 1112.0 643.9 655.8 666.4 674.3 681.9 11365.9 11518.1 11996.8 12000.6 13030.6 660.8 669.1 675.3 675.5 680.0 4910.5 5289.5 5333.1 5456.8 5499.9 101935.0 103706.5 107408.5 107759.5 107981.0 86024.6 91660.5 92764.0 93907.5 93944.0 74777.0 75287.2 77456.0 77664.0 79204.0 10219.4 10250.7 10455.3 10703.0 10759.1 34944.5 35319.5 35381.8 36039.0 37798.4 43956.0 65544.3 67551.0 69363.3 71452.6 18389.4 18679.9 18830.4 19164.8 19191.4 17138.3 20260.7 20429.0 20650.7 20829.9 18709.8 19060.1 19235.8 19292.0 19587.6 18094.5 18468.0 18933.3 19294.4 19512.2 16130.2 16278.4 16295.0 18420.4 18703.2 12346.0 12510.4 12684.4 12690.5 12995.5 13234.9 13239.0 13540.8 13571.5 13773.4 07:01:23 INFO - PID 27253 | -------- Summary: end -------- 07:01:23 INFO - PID 27253 | 07:01:24 INFO - TEST-INFO | 27253: exit 0 07:01:24 INFO - TEST-OK | dromaeo_css | took 1112546ms 07:01:24 INFO - TEST-START | kraken 07:01:24 INFO - Initialising browser for kraken test... 07:01:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54396/getInfo.html -profile /tmp/tmptjLUiT/profile 07:01:24 INFO - TEST-INFO | started process 27610 (/builds/slave/test/build/application/firefox/firefox http://localhost:54396/getInfo.html) 07:01:29 INFO - TEST-INFO | 27610: exit 0 07:01:29 INFO - Browser initialized. 07:01:29 INFO - Running cycle 1/1 for kraken test... 07:01:29 INFO - TEST-INFO | started process 27818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjLUiT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:30 INFO - PID 27818 | 07:01:30 INFO - PID 27818 | (/builds/slave/test/build/application/firefox/firefox:27866): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:01:30 INFO - PID 27818 | 07:01:41 INFO - PID 27818 | RSS: Main: 170901504 07:01:41 INFO - PID 27818 | 07:01:43 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54396/tests/kraken/driver.html?testName=audio-beat-detection) 07:01:44 INFO - PID 27818 | RSS: Main: 177381376 07:01:44 INFO - PID 27818 | 07:01:47 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54396/tests/kraken/driver.html?testName=audio-dft) 07:01:48 INFO - PID 27818 | RSS: Main: 177688576 07:01:48 INFO - PID 27818 | 07:01:51 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54396/tests/kraken/driver.html?testName=audio-fft) 07:01:51 INFO - PID 27818 | RSS: Main: 171147264 07:01:51 INFO - PID 27818 | 07:01:53 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54396/tests/kraken/driver.html?testName=audio-oscillator) 07:01:54 INFO - PID 27818 | RSS: Main: 171569152 07:01:54 INFO - PID 27818 | 07:01:56 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:57 INFO - PID 27818 | RSS: Main: 171683840 07:01:57 INFO - PID 27818 | 07:02:00 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54396/tests/kraken/driver.html?testName=imaging-darkroom) 07:02:01 INFO - PID 27818 | RSS: Main: 174174208 07:02:01 INFO - PID 27818 | 07:02:04 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54396/tests/kraken/driver.html?testName=imaging-desaturate) 07:02:05 INFO - PID 27818 | RSS: Main: 174587904 07:02:05 INFO - PID 27818 | 07:02:07 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54396/tests/kraken/driver.html?testName=json-parse-financial) 07:02:08 INFO - PID 27818 | RSS: Main: 175099904 07:02:08 INFO - PID 27818 | 07:02:10 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:02:10 INFO - PID 27818 | RSS: Main: 174804992 07:02:10 INFO - PID 27818 | 07:02:12 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:02:13 INFO - PID 27818 | RSS: Main: 172142592 07:02:13 INFO - PID 27818 | 07:02:15 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:02:16 INFO - PID 27818 | RSS: Main: 171610112 07:02:16 INFO - PID 27818 | 07:02:18 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:02:19 INFO - PID 27818 | RSS: Main: 172331008 07:02:19 INFO - PID 27818 | 07:02:22 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:02:23 INFO - PID 27818 | RSS: Main: 172441600 07:02:23 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | Cycle 1(1): loaded http://localhost:54396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54396/tests/kraken/driver.html?testName=ai-astar) 07:02:25 INFO - PID 27818 | RSS: Main: 173809664 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | __start_tp_report 07:02:25 INFO - PID 27818 | _x_x_mozilla_page_load 07:02:25 INFO - PID 27818 | _x_x_mozilla_page_load_details 07:02:25 INFO - PID 27818 | |i|pagename|runs| 07:02:25 INFO - PID 27818 | |0;ai-astar;101;109;107;111;108;116;110;102;110;112 07:02:25 INFO - PID 27818 | |1;audio-beat-detection;159;119;148;179;131;153;148;119;186;128 07:02:25 INFO - PID 27818 | |2;audio-dft;165;164;166;163;163;162;173;172;167;165 07:02:25 INFO - PID 27818 | |3;audio-fft;74;78;75;170;78;77;75;75;156;77 07:02:25 INFO - PID 27818 | |4;audio-oscillator;79;83;130;79;79;79;130;79;79;129 07:02:25 INFO - PID 27818 | |5;imaging-gaussian-blur;115;114;115;122;113;114;114;115;115;114 07:02:25 INFO - PID 27818 | |6;imaging-darkroom;151;150;150;151;150;151;150;151;152;151 07:02:25 INFO - PID 27818 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;95 07:02:25 INFO - PID 27818 | |8;json-parse-financial;61;56;58;64;56;57;57;57;57;57 07:02:25 INFO - PID 27818 | |9;json-stringify-tinderbox;54;53;54;54;54;54;54;54;54;55 07:02:25 INFO - PID 27818 | |10;stanford-crypto-aes;81;81;81;86;82;83;82;83;82;81 07:02:25 INFO - PID 27818 | |11;stanford-crypto-ccm;128;128;126;127;127;126;128;137;133;164 07:02:25 INFO - PID 27818 | |12;stanford-crypto-pbkdf2;176;184;173;175;174;174;175;181;183;177 07:02:25 INFO - PID 27818 | |13;stanford-crypto-sha256-iterative;70;70;73;69;73;71;70;69;69;76 07:02:25 INFO - PID 27818 | __end_tp_report 07:02:25 INFO - PID 27818 | __start_cc_report 07:02:25 INFO - PID 27818 | _x_x_mozilla_cycle_collect,945 07:02:25 INFO - PID 27818 | __end_cc_report 07:02:25 INFO - PID 27818 | __startTimestamp1501164145319__endTimestamp 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | ------- Summary: start ------- 07:02:25 INFO - PID 27818 | Number of tests: 14 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:4.48 (4.1%) stddev-sans-first:3.81 07:02:25 INFO - PID 27818 | Values: 101.0 109.0 107.0 111.0 108.0 116.0 110.0 102.0 110.0 112.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:150.50 stddev:23.36 (15.5%) stddev-sans-first:24.37 07:02:25 INFO - PID 27818 | Values: 159.0 119.0 148.0 179.0 131.0 153.0 148.0 119.0 186.0 128.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.50 stddev:3.74 (2.3%) stddev-sans-first:3.95 07:02:25 INFO - PID 27818 | Values: 165.0 164.0 166.0 163.0 163.0 162.0 173.0 172.0 167.0 165.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.00 stddev:36.80 (48.4%) stddev-sans-first:38.35 07:02:25 INFO - PID 27818 | Values: 74.0 78.0 75.0 170.0 78.0 77.0 75.0 75.0 156.0 77.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:24.23 (30.7%) stddev-sans-first:25.03 07:02:25 INFO - PID 27818 | Values: 79.0 83.0 130.0 79.0 79.0 79.0 130.0 79.0 79.0 129.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:2.51 (2.2%) stddev-sans-first:2.67 07:02:25 INFO - PID 27818 | Values: 115.0 114.0 115.0 122.0 113.0 114.0 114.0 115.0 115.0 114.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 07:02:25 INFO - PID 27818 | Values: 151.0 150.0 150.0 151.0 150.0 151.0 150.0 151.0 152.0 151.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:02:25 INFO - PID 27818 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.00 stddev:2.54 (4.5%) stddev-sans-first:2.45 07:02:25 INFO - PID 27818 | Values: 61.0 56.0 58.0 64.0 56.0 57.0 57.0 57.0 57.0 57.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 07:02:25 INFO - PID 27818 | Values: 54.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 55.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.55 (1.9%) stddev-sans-first:1.58 07:02:25 INFO - PID 27818 | Values: 81.0 81.0 81.0 86.0 82.0 83.0 82.0 83.0 82.0 81.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:128.00 stddev:11.64 (9.1%) stddev-sans-first:12.23 07:02:25 INFO - PID 27818 | Values: 128.0 128.0 126.0 127.0 127.0 126.0 128.0 137.0 133.0 164.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:176.50 stddev:3.99 (2.3%) stddev-sans-first:4.21 07:02:25 INFO - PID 27818 | Values: 176.0 184.0 173.0 175.0 174.0 174.0 175.0 181.0 183.0 177.0 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.50 stddev:2.31 (3.3%) stddev-sans-first:2.42 07:02:25 INFO - PID 27818 | Values: 70.0 70.0 73.0 69.0 73.0 71.0 70.0 69.0 69.0 76.0 07:02:25 INFO - PID 27818 | -------- Summary: end -------- 07:02:25 INFO - PID 27818 | 07:02:25 INFO - PID 27818 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:02:26 INFO - TEST-INFO | 27818: exit 0 07:02:26 INFO - TEST-OK | kraken | took 62166ms 07:02:26 INFO - SUITE-END | took 1174s 07:02:26 INFO - Completed test suite (00:19:34) 07:02:26 INFO - javascript benchmark 07:02:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8334.148606216022, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.4194703006415, 3117.9532307015393, 3135.404273188094, 3161.7786754927156, 3176.4600017996936, 6056.727447264872, 6104.023356262999, 6153.630782153074, 6191.0, 6209.379062093794, 6202.906956395657, 6232.750689972396, 6243.344448832875, 6275.3410891856265, 6299.433051025407, 5539.944600554003, 5649.23735295736, 5693.146028095788, 5739.053056245714, 5801.970990145043, 5630.774769009235, 5662.631928924628, 5722.599418040739, 5737.282839645044, 5749.856253593652, 5650.180723795027, 5670.37625861157, 5719.999000174974, 5747.33905600855, 5758.193852860602, 5626.774929002835, 5678.403767604384, 5729.28383952006, 5741.33974592923, 5745.540356771448, 5508.724563771835, 5613.607047506676, 5624.775008999635, 5640.097584386478, 5678.829635110953, 6070.484008859252, 6161.599496032743, 6164.6917654117115, 6172.537059720539, 6176.536759742992, 6620.768273110418, 6644.767433139865, 6772.11962444879, 6773.254941956381, 6783.321667833177, 6638.701258443333, 6695.196576410862, 6703.631300278483, 6728.360805723449, 6734.629595372253, 6199.473044791198, 6234.0960560718895, 6250.6874656267, 6269.5611307208055, 6279.340669229757, 6861.416779573692, 6895.75864844728, 6956.0609317741455, 6969.686364113627, 6981.441484681213, 6376.808695739135, 6555.115059466911, 6556.606603603799, 6560.671966401661, 6570.671466426659, 6648.601083934979, 6670.7665231716655, 6677.799666010027, 6678.432333251631, 6682.064510968468, 6640.0, 6641.701123449457, 6659.101021362151, 6667.733290668416, 6682.5322227444585, 6622.072909792633, 6652.634105124264, 6687.1975362956755, 6743.1908171019795, 6756.121704178524, 5358.651687640291, 5382.91925621116, 5446.074167391553, 5457.072297709399, 5458.2904222451625, 4524.683272170916, 4560.201964656172, 4574.862754117382, 4592.035672508744, 4664.160451118832, 5785.623934444247, 5793.449622285876, 5813.04084825999, 5817.50551203144, 5823.650580965155, 6582.012698095324, 6652.534322597372, 6658.300878407795, 6659.933400666028, 6663.4669226461765, 5756.884862302731, 5778.8266352009505, 5856.092305692625, 5859.296884373903, 5867.031939729897, 5812.070068788974, 5850.736716847752, 5882.676452795137, 5961.135635332853, 5963.701814909324, 6424.16485856845, 6443.645599491979, 6449.451796597342, 6453.741850326029, 6456.967715161488, 6643.534952553468, 6648.867022659617, 6734.932650673627, 6739.292374300628, 6744.494162937701, 6536.869262614626, 6566.343365663395, 6575.079488871466, 6582.572132811352, 6590.1103351046995, 6541.901871471837, 6565.835854103495, 6644.83387915306, 6659.367360100783, 6670.799876003728, 6618.470522358296, 6685.832854178684, 6698.966505167443, 6748.527603067738, 6797.592144471348, 6422.710978005907, 6497.4477169441125, 6499.025146228104, 6510.0885875976455, 6545.967270163619, 6530.608163510205, 6548.8035358939305, 6553.967230163818, 6558.278589355263, 6567.770128045496, 6450.774222902176, 6471.514636402195, 6482.384173503509, 6497.317781632861, 6500.057491663588, 6536.6731663415685, 6538.313477084837, 6590.176227971504, 6628.403443690091, 6637.966810165918, 6240.656763878031, 6296.496280297473, 6322.557420980671, 6328.46208072319, 6404.967975160281], "value": 6091.62211909825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [829.593499185399, 834.4659417972495, 851.5742128935532, 881.9250363719084, 885.7342797160854, 41973.79013104934, 42519.0, 42818.785906070465, 42837.35743963843, 42858.7857060715, 37497.50009999597, 37805.43291850617, 37807.43288850669, 37812.81093594535, 37876.81061594695, 6968.756093536727, 7084.114485689289, 7104.85790284194, 7114.822129446753, 7132.215456299803, 6993.685284162199, 6994.020837082812, 7030.543014704053, 7086.9645651771925, 7089.680964356617, 7101.289871012909, 7404.4816862819625, 7975.7607271781935, 7998.600069996506, 8005.67977280911, 7945.682172713085, 7963.283304502623, 7974.5215287082965, 7980.401469889782, 7981.521108733495, 7678.078630564312, 7744.186860379636, 7798.688052477894, 7840.255175758294, 7848.175941526171, 39508.802455987825, 39808.0, 39826.40260396097, 39986.80006599949, 40031.39952900709, 3450.7929524228625, 3508.0703613542432, 3508.771929824579, 3509.438489841639, 3517.296540691872, 31699.0, 32044.519332210035, 32063.0, 32153.1961700957, 32305.6769432305, 4679.81280748773, 4734.147853386389, 4753.548412900769, 4789.042191561667, 4796.112719146934, 180711.0, 181924.0, 189306.99999999863, 193440.0, 197671.01164494228, 48063.75968120137, 48080.0, 48225.75887120612, 48270.0, 48300.5169948296, 50320.0, 50497.0, 50521.74739126281, 50650.746746266035, 50691.47925562239, 16386.508404747878, 16412.09733464647, 16463.83536164623, 16521.33914643425, 16647.667046659, 13738.793918091036, 13864.168149911038, 13881.375338109809, 13885.305734713224, 13890.58328250154, 13712.0, 13825.170489770646, 13846.307684615931, 14044.368003439666, 14127.929360353133, 5448.0, 5479.561635069185, 5485.122380419114, 5511.311086114236, 5534.695591742493, 886.8913857677902, 912.5619702542684, 921.3872774604947, 939.112538650982, 969.4813274897896, 20829.854358010456, 21341.78658213429, 21719.0, 28901.0, 28919.71080289212, 1043.5564884923876, 1061.697416236369, 1080.9297395669257, 1095.424901926479, 1097.160672085855, 11652.184347095792, 11775.17573769845, 11780.352080635646, 11872.10959178065, 11963.700907477209, 235169.0, 237274.0, 237516.0, 237832.0, 238540.0, 52687.0, 52813.0, 53127.20309195365, 53163.0, 53206.20190697143, 1391.3530208452914, 1469.441612187362, 1474.7492926202572, 1477.682298305848, 1502.6318551954841, 20852.77345774979, 21273.7872621278, 21618.89190554037, 21967.23114690978, 22187.1125154992, 37189.25621487501, 37279.0, 37316.81341593383, 37408.81295593613, 37424.438633421065, 195689.0, 197056.0, 197227.0, 197518.0, 197822.0, 32032.5195122078, 33331.83334083314, 33630.159246019044, 33817.3236535263, 33822.66177338195, 43115.7844210777, 43202.0, 43567.56432435762, 43718.0, 43753.56246437495, 28163.859180704785, 30244.0, 30681.8465907669, 30751.692483074883, 30854.691453085183, 29002.7099729, 29148.708512915447, 29998.85000574983, 30115.849420752755, 30215.546766798954, 38841.41737873878, 38859.805700971316, 39120.21759564849, 39487.80256098701, 39542.60457395389, 31368.37263254768, 32699.0, 33050.0, 33552.49671254884, 33987.83006084954, 24255.272341829772, 24320.51358972846, 24396.26811195667, 24585.262442126765, 24748.257552273462], "value": 16984.742766989526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6016029020121, 585.3941170888131, 588.1912370490576, 588.2617315269333, 592.386879579635, 22207.44481387966, 22483.887580562114, 23019.194328198515, 23022.53954920903, 23043.42391440215, 24353.904074316655, 25892.22323330303, 26020.21939341818, 26029.60955585663, 26110.869445652792, 6442.194725659293, 6612.834679133012, 6620.801375958705, 6623.867522649544, 6631.137952066225, 6108.969455152718, 6493.70778314977, 6551.181102362205, 6556.016597510364, 6597.505187110962, 6521.543491955541, 6552.049952756847, 6554.279029306773, 6554.639494827807, 6569.441597464197, 6495.740170393178, 6527.118838956728, 6543.149390579242, 6573.605583664996, 6583.374579414948, 6106.847328816771, 6114.0, 6116.143739876421, 6119.5410344224365, 6119.755209791648, 28543.000994965078, 29694.851525742448, 29829.0, 29897.850510747525, 30072.248193795112, 1867.4491025147613, 1909.026396537762, 1909.1981367825547, 1911.4838993471685, 1913.6651086059883, 18704.906475467535, 19250.22999080035, 19253.32613358526, 19257.518562035923, 19266.0, 2329.743728189898, 2333.4866329407505, 2342.0, 2399.1722855614785, 2399.376162197841, 127841.0, 129452.0, 130855.0, 134423.0, 134508.6549134506, 14066.648333791532, 14503.709925801424, 14727.484538041117, 15082.924585377003, 15118.0, 23316.65025024626, 23475.295741127793, 23538.29385118449, 23546.0, 23551.882240588686, 9937.552810123561, 10159.0, 10269.589216431408, 10296.382217067, 10461.424621645883, 9563.09150630689, 9624.51877406127, 9628.66299679508, 9705.223582113415, 9818.852717209247, 7736.497127686683, 8853.51305678194, 8964.14840590143, 8995.820083598423, 9127.771805704777, 2623.5933430318332, 2681.6781986161786, 2688.4354285600243, 2688.4623075385, 2784.763295119897, 923.3075193604797, 930.8324501589643, 934.672864497434, 963.9566219519999, 973.2505970402892, 18897.24411023571, 19307.131179096974, 19447.513812154528, 19853.30513432052, 22990.885045574665, 988.2242439684813, 989.2580564576567, 1016.4917541229386, 1018.5314755212537, 1030.3663247103127, 10740.462976851282, 11134.665960021212, 11369.431528423711, 11369.602063927889, 11529.596464123715, 541692.0, 550624.0, 551675.0, 558083.0, 564100.0, 119563.0, 120247.0, 120766.0, 121909.39045304716, 122196.38901805434, 1249.1693024138847, 1265.1270623269913, 1289.6002239305844, 1290.2452065541763, 1296.500847173845, 17091.48725538236, 17773.46679599614, 17941.102944852442, 18444.907775461037, 18620.0, 54662.72668636632, 55880.441195587526, 58278.0, 58529.0, 59736.70131649314, 72701.6364918172, 73022.0, 73046.26953730395, 74482.0, 74591.62704186444, 12416.130870838955, 12875.678108047374, 14518.346674399467, 14803.111813291236, 14823.40706371733, 23413.53172936566, 24088.397790055387, 24147.637785433584, 24437.26688199286, 24898.626520601843, 18980.905095474987, 19092.8090719091, 19205.32781352646, 19231.230750770374, 19306.32427865018, 15501.147436890627, 16885.24016419289, 17059.0, 17340.566485837953, 17393.478195654152, 19443.0, 19638.0, 19748.321392681784, 19835.30576429818, 19996.0, 14817.33322000491, 15008.699826003638, 15036.849631503545, 15053.397864085751, 15162.772558411853, 17631.559211019827, 17972.730409044136, 18718.0, 19129.808701912803, 19327.710084348466], "value": 12064.785554786762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.2800779590714, 1418.9006769526138, 1420.1337184317567, 1422.5021242565097, 1423.9715205695886, 13458.932705336472, 13914.860851391482, 13923.443062277509, 13971.860281397183, 13982.720345593081, 11774.529018839236, 12155.513779448811, 13573.932130339359, 13955.79066314006, 13961.09252898561, 2524.3941454050987, 2579.8581078040793, 2588.4564241509306, 2589.9870500647567, 2595.3511622094475, 2461.6307553866886, 2506.373406648338, 2573.6010918307597, 2577.30412788547, 2583.289595361272, 2629.106103924665, 2636.5122452346377, 2646.748558886912, 2652.071774878796, 2654.3496843273424, 2470.703515578124, 2497.051120574179, 2507.135038411745, 2511.1462102885107, 2512.321673148249, 2410.927672169838, 2431.1004928176512, 2451.7793398594213, 2458.606622940321, 2458.704955405345, 13223.338833058404, 13404.664883377896, 13450.192988420726, 13459.394327255297, 13469.797953030713, 7353.338199562065, 7505.136909255396, 7579.204183560757, 7633.465657403984, 7649.426293027989, 4697.0, 4822.590079843218, 4891.192953162724, 4950.653454258203, 4993.775280112403, 1858.7676540432446, 1869.3270422647836, 1891.5176629959271, 1900.3253844885144, 1913.8373238274764, 20954.790452095436, 21078.78921210799, 21131.47171320714, 21198.152073917026, 21220.575588488144, 5999.910001349983, 6070.453659170696, 6202.875942481125, 6210.472109870621, 6272.498200143978, 14781.408743650349, 14819.333130009176, 14881.404743810126, 14919.776203356958, 14952.401903923721, 7045.68294426752, 7142.642867856586, 7143.0, 7160.319769621878, 7164.0, 6249.718762655601, 6608.339166083353, 6611.735530578723, 6616.536842420985, 6670.366315200048, 4973.254011898244, 5179.689218646893, 5188.92216616751, 5195.896082078338, 5223.0, 1388.7361401333715, 1456.2427537680346, 1485.7994170787022, 1489.9553013409616, 1515.886308526865, 759.8936148939152, 765.0780809124991, 788.7200043984418, 805.6133056133089, 810.9310708589718, 6924.23833378328, 6989.0, 7150.5352152109945, 7172.856542869114, 7242.9275707243305, 890.692711014699, 916.1525588830439, 938.3900464697864, 947.7867479816986, 950.9191718703987, 3946.092398748304, 4245.3631955206965, 4488.4165058542185, 4546.704464209815, 4546.818127274872, 18253.17860696272, 18838.15228314729, 19047.0, 19405.320813771734, 19448.611027779367, 18857.810253953143, 19274.32539861098, 19424.902875485815, 19464.8053519463, 19506.31727889517, 10679.83980240297, 10701.678949631523, 10777.35335879834, 10843.07833834117, 10912.454377281105, 6752.93247067523, 6986.336298051677, 7094.822629434306, 7230.168530619047, 7273.927260727537, 15786.60533486626, 16718.49844504667, 17070.914645426692, 17077.91461042687, 17401.56496087608, 17199.0, 17258.13709314504, 17361.045142516778, 17432.21555030052, 17512.91243543774, 10476.895231047592, 10579.0, 10582.365058096231, 10583.470826458492, 10583.4708264588, 12761.234325940473, 12860.935695321463, 12892.41984110736, 12949.805752913902, 13119.147255428366, 9618.0, 10062.295639305179, 10138.03688649577, 10262.332948358333, 10274.434906080238, 9875.753106172404, 10176.949115254376, 10332.17342612574, 10361.119304859172, 10628.468576570986, 8514.0, 8710.695125670825, 8716.215540601377, 8718.60766265507, 8746.956265218887, 6400.743970241325, 6479.157709497735, 6527.67361631926, 6630.7679231226675, 6707.731690732316, 6183.84540386494, 6237.5321850860455, 6249.906251406142, 6413.927156255718, 6466.418022378009], "value": 6073.6545936046405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.14769562483156, 499.022583718897, 511.7390131033174, 512.7718165416392, 514.3955851874048, 6129.927262729021, 6155.060761112885, 6202.3487533808975, 6205.441510264075, 6250.374962503759, 5853.707314634273, 5953.404659534044, 6004.609700369473, 6029.216201893759, 6067.453929146376, 4764.523547645243, 4793.13067903517, 4828.61371090312, 4843.200871856139, 4879.951200487985, 4676.719396836201, 4829.22732362822, 4836.733979631119, 4843.4187897452175, 4849.720631303282, 4716.98584804267, 4792.688475249115, 4813.90372192556, 4834.854954351375, 4887.169181239198, 4774.236122220445, 4818.494058123882, 4822.228443449031, 4864.878378040542, 4869.836289972059, 4305.289627211507, 4336.349547567858, 4346.326319420495, 4372.628326592244, 4390.517043125254, 5916.615419997686, 5935.6438613682885, 5969.835882003011, 6005.399460054004, 6011.158437818709, 5515.944840551583, 5534.695591742493, 5608.971955140199, 5609.0, 5641.8589535261535, 6420.683759829224, 6425.0, 6449.419552240274, 6494.188226471691, 6523.347665233486, 4747.477777444478, 4762.547557981986, 4775.14047471455, 4785.162596545625, 4792.041591681643, 6766.864662706718, 6846.760363387308, 6876.0, 6881.621510816903, 6915.654217289115, 4857.149998750205, 4868.95131048685, 4889.926651100236, 4906.239532872411, 4910.680805747615, 4959.7272150032095, 4970.850874473772, 4977.800887964441, 4995.701117709422, 4996.525330093708, 5566.721663916788, 5588.30146231721, 5603.299587551556, 5626.521745651584, 5642.266505354278, 6424.935750642434, 6450.322716114741, 6473.417392434703, 6482.740690372332, 6577.375149360803, 1626.7071927053244, 1656.724322271844, 1658.552190908448, 1663.20166320167, 1721.28566644841, 1170.12825445044, 1186.9940650296694, 1195.9162858599814, 1200.7178313096415, 1204.3978010994504, 5629.296337957755, 5639.689817060101, 5689.487946084872, 5696.458836410535, 5708.343540492813, 6367.713452894631, 6570.653016131681, 6575.210974683068, 6596.175478065242, 6652.268250492442, 5662.462066103713, 5721.342045664718, 5724.542036637059, 5758.7696492140685, 5761.48146666802, 3448.3620530201993, 3474.756767026284, 3505.5618047744033, 3531.205478767257, 3535.292941411728, 6404.327545607644, 6423.0, 6473.385028422293, 6501.47988160946, 6511.186101737283, 6783.389494945479, 6807.625580593115, 6831.897521537181, 6884.724611015503, 6914.481413893877, 6401.167848179707, 6417.9679101605125, 6485.0, 6489.67551622417, 6490.545661803629, 6546.149000629887, 6565.901511477427, 6680.298568650416, 6699.263081061177, 6709.429698475489, 6584.2551723794195, 6615.4784399589325, 6652.501062420434, 6670.83322916931, 6689.7289514992, 6421.967890160519, 6429.292777794345, 6451.806445806634, 6454.160959075478, 6497.447716943923, 4862.246351815475, 4863.635227357891, 4903.215485522299, 4909.656324057281, 4914.778834952364, 6399.936000639934, 6657.201135863727, 6754.290799466182, 6795.830104247433, 6814.250432452327, 6254.906176407267, 6257.249130104235, 6318.810435686937, 6493.837654058686, 6545.607263564201, 6409.8718025640155, 6412.35876412355, 6461.512317757791, 6479.481641468766, 6517.446017088411, 6418.967905160444, 6428.0, 6432.388923052303, 6462.321456247027, 6481.4814814815645, 6434.292227855026, 6505.154329937078, 6510.576812507172, 6574.178227721535, 6606.0, 6275.874482510233, 6286.74853005893, 6311.431971122621, 6313.600831683931, 6356.745730170926], "value": 4969.387684893527, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.3628723606239, 906.6781292641112, 912.2291663544311, 924.3668087360156, 927.0960813207124, 18219.18013689384, 19145.42563723087, 19252.614947701037, 19287.421377358703, 19305.0, 19676.606467870668, 21351.466213344673, 21389.0, 21503.354899353006, 21689.457763555918, 971.7619183300084, 988.8368419210822, 990.7027891632481, 991.2565575818137, 992.4541502173776, 1003.5684655598089, 1045.2056437107776, 1048.8164571200048, 1050.2228351020267, 1057.8360354145082, 1089.4008295437518, 1098.505672447398, 1102.079763397564, 1102.4322473925895, 1111.5053801058532, 1088.031651829872, 1090.4820210400076, 1094.6278265389726, 1101.752105776202, 1103.2112039891476, 795.3637090327715, 796.9003874515686, 798.700487317256, 800.5716941436361, 806.0931452116369, 18119.094045297814, 18586.16362263688, 18754.0, 19098.52253693669, 19123.139458724392, 19441.22235110594, 19576.902115489473, 19854.00729963496, 19908.104135313944, 20429.69355459669, 15035.097894126278, 15246.085234885943, 15379.615509612237, 15542.456014039455, 15688.921555392264, 3018.9698103019127, 3092.1805721483825, 3095.5666206731075, 3102.860371283298, 3105.1616063662686, 115429.42285288604, 117747.0, 122473.0, 123973.0, 126491.0, 15510.767338489932, 15513.534593962198, 15829.920850395674, 15914.840851591336, 15921.203939802963, 26459.338516537242, 29912.40175196484, 30132.84933575318, 30178.24554386114, 30240.69759302379, 8283.544405057779, 8393.748187554384, 8400.705975290835, 8436.915630843612, 8498.107698691672, 4068.349064149722, 4148.481439820022, 4152.065785198306, 4155.252054630135, 4156.56356082613, 4707.952920470751, 4913.70517768935, 5557.749901254453, 5658.632188907708, 5677.858053548612, 1073.3238060022136, 1092.5575142067476, 1104.6023431564631, 1105.8396532502902, 1112.0436424674774, 643.8905386084377, 655.7999810057883, 666.3702800853147, 674.3223060823939, 681.9454443644596, 11365.943170284096, 11518.078553715683, 11996.820047699117, 12000.63998080059, 13030.609081727564, 660.7522179182806, 669.1401549009597, 675.3280485916545, 675.4630069094983, 679.972801087951, 4910.459849416561, 5289.471052894757, 5333.093464062095, 5456.836294911159, 5499.862503437446, 101935.0, 103706.4814675937, 107408.46295768471, 107759.46120269349, 107981.0, 86024.5698771502, 91660.54169729109, 92764.0, 93907.53046234862, 93944.0, 74777.0, 75287.22460814839, 77456.0, 77664.0, 79204.0, 10219.386836789816, 10250.743731406475, 10455.320404173704, 10703.0, 10759.08547773448, 34944.475832862016, 35319.470207947415, 35381.82309088438, 36039.0, 37798.43302350522, 43956.0, 65544.34455655383, 67551.0, 69363.30636693568, 71452.64273678807, 18389.448316550526, 18679.906600467453, 18830.435086947415, 19164.8083519163, 19191.424257271745, 17138.314467421664, 20260.696089558372, 20429.0, 20650.690239646116, 20829.89585052065, 18709.812901870806, 19060.1422935971, 19235.807641923402, 19292.0, 19587.60824783468, 18094.457166285032, 18468.0, 18933.33733319327, 19294.421167365002, 19512.21951121939, 16130.193490325672, 16278.43025494102, 16295.0, 18420.355287565406, 18703.1583578742, 12346.0, 12510.374481276081, 12684.365781710692, 12690.492380304684, 12995.545155919875, 13234.933825330812, 13239.0, 13540.79688804649, 13571.52499662507, 13773.38019789132], "value": 8893.547153565307, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 107.0, 111.0, 108.0, 116.0, 110.0, 102.0, 110.0, 112.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 119.0, 148.0, 179.0, 131.0, 153.0, 148.0, 119.0, 186.0, 128.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 163.0, 163.0, 162.0, 173.0, 172.0, 167.0, 165.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 170.0, 78.0, 77.0, 75.0, 75.0, 156.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 130.0, 79.0, 79.0, 79.0, 130.0, 79.0, 79.0, 129.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 122.0, 113.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 150.0, 151.0, 150.0, 151.0, 152.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 58.0, 64.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 86.0, 82.0, 83.0, 82.0, 83.0, 82.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 126.0, 127.0, 127.0, 126.0, 128.0, 137.0, 133.0, 164.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 184.0, 173.0, 175.0, 174.0, 174.0, 175.0, 181.0, 183.0, 177.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 69.0, 73.0, 71.0, 70.0, 69.0, 69.0, 76.0], "value": 71.0, "unit": "score"}]}]} 07:02:26 INFO - Return code: 0 07:02:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:02:26 INFO - # TBPL SUCCESS # 07:02:26 INFO - Running post-action listener: _package_coverage_data 07:02:26 INFO - Running post-action listener: _resource_record_post_action 07:02:26 INFO - [mozharness: 2017-07-27 14:02:26.604691Z] Finished run-tests step (success) 07:02:26 INFO - Running post-run listener: _resource_record_post_run 07:02:26 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 430874624; Read time: 0; Write time: 344296 07:02:26 INFO - TinderboxPrint: CPU usage
13.1% 07:02:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:02:26 INFO - TinderboxPrint: I/O write bytes / time
430,874,624 / 344,296 07:02:26 INFO - TinderboxPrint: CPU idle
8,261.3 (86.9%) 07:02:26 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 07:02:26 INFO - TinderboxPrint: Swap in / out
0 / 0 07:02:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107610112; Read time: 0; Write time: 99524 07:02:26 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:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 323264512; Read time: 0; Write time: 244772 07:02:27 INFO - Running post-run listener: _upload_blobber_files 07:02:27 INFO - Blob upload gear active. 07:02:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:02:27 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:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:02:27 INFO - (blobuploader) - INFO - Open directory for files ... 07:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:02:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:28 INFO - (blobuploader) - INFO - Done attempting. 07:02:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:02:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:02:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:29 INFO - (blobuploader) - INFO - Done attempting. 07:02:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:02:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:33 INFO - (blobuploader) - INFO - Done attempting. 07:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:34 INFO - (blobuploader) - INFO - Done attempting. 07:02:34 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:34 INFO - Return code: 0 07:02:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:02:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0f31505b889fd65e659b1a8660c0821509f20bbaad720eb17fe5815f8971a7b9523731a11a30f9945e0c5d79a9bf991f0c460751c10d2371ee876fb81b2ffbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28680ab9e8e39fc9a47e948092db99ad420bbfdb230d07b63dac84618c104010802d5e9a317f0cd59be6410de42f8da34bfc1fa96e540426231f4450fe7ed506", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a5c7be3732d21bd8bfc1fb9f8309a993d10d370232bdf47537bc99032ac201a01f213af1ec1c7af574143e8e8645291a9e0de9cbf65ba4d968c0ff65dd4a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a86d02856481bc47a03c4ddf4e4f17b686840eb69dd854f5f4eb2e49931c6a4b19c6506326d192f5e6df582aa9f9bfe3a053420701b161a99e6f1b8727a67df"} 07:02:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:02:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:02:34 INFO - Contents: 07:02:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0f31505b889fd65e659b1a8660c0821509f20bbaad720eb17fe5815f8971a7b9523731a11a30f9945e0c5d79a9bf991f0c460751c10d2371ee876fb81b2ffbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28680ab9e8e39fc9a47e948092db99ad420bbfdb230d07b63dac84618c104010802d5e9a317f0cd59be6410de42f8da34bfc1fa96e540426231f4450fe7ed506", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a5c7be3732d21bd8bfc1fb9f8309a993d10d370232bdf47537bc99032ac201a01f213af1ec1c7af574143e8e8645291a9e0de9cbf65ba4d968c0ff65dd4a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a86d02856481bc47a03c4ddf4e4f17b686840eb69dd854f5f4eb2e49931c6a4b19c6506326d192f5e6df582aa9f9bfe3a053420701b161a99e6f1b8727a67df"} 07:02:34 INFO - Running post-run listener: copy_logs_to_upload_dir 07:02:34 INFO - Copying logs to upload dir... 07:02:34 INFO - mkdir: /builds/slave/test/build/upload/logs 07:02:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.199866 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-27 07:02:30.468385) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:30.474188) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0f31505b889fd65e659b1a8660c0821509f20bbaad720eb17fe5815f8971a7b9523731a11a30f9945e0c5d79a9bf991f0c460751c10d2371ee876fb81b2ffbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28680ab9e8e39fc9a47e948092db99ad420bbfdb230d07b63dac84618c104010802d5e9a317f0cd59be6410de42f8da34bfc1fa96e540426231f4450fe7ed506", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a5c7be3732d21bd8bfc1fb9f8309a993d10d370232bdf47537bc99032ac201a01f213af1ec1c7af574143e8e8645291a9e0de9cbf65ba4d968c0ff65dd4a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a86d02856481bc47a03c4ddf4e4f17b686840eb69dd854f5f4eb2e49931c6a4b19c6506326d192f5e6df582aa9f9bfe3a053420701b161a99e6f1b8727a67df"} build_url:https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/NOjUXIa0QK-7lZYie13cWw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0f31505b889fd65e659b1a8660c0821509f20bbaad720eb17fe5815f8971a7b9523731a11a30f9945e0c5d79a9bf991f0c460751c10d2371ee876fb81b2ffbe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/28680ab9e8e39fc9a47e948092db99ad420bbfdb230d07b63dac84618c104010802d5e9a317f0cd59be6410de42f8da34bfc1fa96e540426231f4450fe7ed506", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a5c7be3732d21bd8bfc1fb9f8309a993d10d370232bdf47537bc99032ac201a01f213af1ec1c7af574143e8e8645291a9e0de9cbf65ba4d968c0ff65dd4a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a86d02856481bc47a03c4ddf4e4f17b686840eb69dd854f5f4eb2e49931c6a4b19c6506326d192f5e6df582aa9f9bfe3a053420701b161a99e6f1b8727a67df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:30.498034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:30.498336) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1501162565.410335-1608874884 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004713 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 07:02:30.580794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 07:02:30.581150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 07:02:30.581420) ========= ========= Total master_lag: 0.15 =========