builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1501929415.87 results: success (0) revision: a9182f92641b24d0a972886aed27e784004a343f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.865894) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.866316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.866642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.889835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.890122) ========= 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-1501917258.600740-194931230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-05 03:36:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-08-05 03:36:57 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.986950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.987309) ========= 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-1501917258.600740-194931230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018525 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:56.040284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-05 03:36:56.040946) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a9182f92641b24d0a972886aed27e784004a343f --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 a9182f92641b24d0a972886aed27e784004a343f --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-1501917258.600740-194931230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-05 03:36:57,687 truncating revision to first 12 chars 2017-08-05 03:36:57,687 Setting DEBUG logging. 2017-08-05 03:36:57,687 attempt 1/10 2017-08-05 03:36:57,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a9182f92641b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-05 03:36:58,556 unpacking tar archive at: mozilla-central-a9182f92641b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.194450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-05 03:36:57.252320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.253127) ========= script_repo_revision: a9182f92641b24d0a972886aed27e784004a343f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.254099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.254814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.266307) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-05 03:36:57.266623) ========= /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-1501917258.600740-194931230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:59 INFO - MultiFileLogger online at 20170805 03:36:59 in /builds/slave/test 03:36:59 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 03:36:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:59 INFO - {'append_to_log': False, 03:36:59 INFO - 'base_work_dir': '/builds/slave/test', 03:36:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:36:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:59 INFO - 'branch': 'Firefox-Non-PGO', 03:36:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:59 INFO - 'code_coverage': False, 03:36:59 INFO - 'config_files': ('talos/linux_config.py',), 03:36:59 INFO - 'default_actions': ('clobber', 03:36:59 INFO - 'read-buildbot-config', 03:36:59 INFO - 'download-and-extract', 03:36:59 INFO - 'populate-webroot', 03:36:59 INFO - 'create-virtualenv', 03:36:59 INFO - 'install', 03:36:59 INFO - 'setup-mitmproxy', 03:36:59 INFO - 'run-tests'), 03:36:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:59 INFO - 'disable_ccov_upload': False, 03:36:59 INFO - 'download_minidump_stackwalk': True, 03:36:59 INFO - 'download_symbols': 'ondemand', 03:36:59 INFO - 'enable_stylo': False, 03:36:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:59 INFO - 'gecko_profile': False, 03:36:59 INFO - 'gecko_profile_interval': 0, 03:36:59 INFO - 'installer_path': 'installer.exe', 03:36:59 INFO - 'log_level': 'info', 03:36:59 INFO - 'log_name': 'talos', 03:36:59 INFO - 'log_to_console': True, 03:36:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:59 INFO - 'opt_config_files': (), 03:36:59 INFO - 'pip_index': False, 03:36:59 INFO - 'suite': 'dromaeojs-e10s', 03:36:59 INFO - 'system_bits': '32', 03:36:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:59 INFO - 'title': 'talos-linux64-ix-068', 03:36:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:59 INFO - 'use_talos_json': True, 03:36:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:59 INFO - 'work_dir': 'build'} 03:36:59 INFO - [mozharness: 2017-08-05 10:36:59.029573Z] Running clobber step. 03:36:59 INFO - Running pre-action listener: _resource_record_pre_action 03:36:59 INFO - Running main action method: clobber 03:36:59 INFO - rmtree: /builds/slave/test/build 03:36:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:37:00 INFO - Running post-action listener: _resource_record_post_action 03:37:00 INFO - [mozharness: 2017-08-05 10:37:00.058861Z] Finished clobber step (success) 03:37:00 INFO - [mozharness: 2017-08-05 10:37:00.058962Z] Running read-buildbot-config step. 03:37:00 INFO - Running pre-action listener: _resource_record_pre_action 03:37:00 INFO - Running main action method: read_buildbot_config 03:37:00 INFO - Using buildbot properties: 03:37:00 INFO - { 03:37:00 INFO - "project": "", 03:37:00 INFO - "product": "firefox", 03:37:00 INFO - "who": "archaeopteryx@coole-files.de", 03:37:00 INFO - "installer_path": "public/build/target.tar.bz2", 03:37:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:37:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:37:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:37:00 INFO - "stage_platform": "linux64", 03:37:00 INFO - "basedir": "/builds/slave/test", 03:37:00 INFO - "buildnumber": 1060, 03:37:00 INFO - "platform": "ubuntu64_hw", 03:37:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:37:00 INFO - "slavebuilddir": "test", 03:37:00 INFO - "taskId": "YY521dseS6iIiztE5MsOwg", 03:37:00 INFO - "branch": "mozilla-central", 03:37:00 INFO - "script_repo_revision": "production", 03:37:00 INFO - "revision": "a9182f92641b24d0a972886aed27e784004a343f", 03:37:00 INFO - "slavename": "talos-linux64-ix-068", 03:37:00 INFO - "repo_path": "mozilla-central" 03:37:00 INFO - } 03:37:00 INFO - Finding installer, test and symbols from parent task. 03:37:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YY521dseS6iIiztE5MsOwg'}, attempt #1 03:37:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YY521dseS6iIiztE5MsOwg'}, attempt #1 03:37:00 INFO - Task dependencies: KWzyzWIlQJ2iudAWGgv8fQ 03:37:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ'}, attempt #1 03:37:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 03:37:01 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.test_packages.json 03:37:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.crashreporter-symbols.zip 03:37:01 INFO - Running post-action listener: _resource_record_post_action 03:37:01 INFO - [mozharness: 2017-08-05 10:37:01.434570Z] Finished read-buildbot-config step (success) 03:37:01 INFO - [mozharness: 2017-08-05 10:37:01.434791Z] Running download-and-extract step. 03:37:01 INFO - Running pre-action listener: _resource_record_pre_action 03:37:01 INFO - Running main action method: download_and_extract 03:37:01 INFO - mkdir: /builds/slave/test/build/tests 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - trying https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.test_packages.json 03:37:01 INFO - Downloading https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:37:01 INFO - Downloaded 989 bytes. 03:37:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:37:01 INFO - Using the following test package requirements: 03:37:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:37:01 INFO - u'common': [u'target.common.tests.zip'], 03:37:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:37:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:37:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:37:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:37:01 INFO - u'mozbase': [u'target.common.tests.zip'], 03:37:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:37:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:37:01 INFO - u'web-platform': [u'target.common.tests.zip', 03:37:01 INFO - u'target.web-platform.tests.tar.gz'], 03:37:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:37:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:37:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip 03:37:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:37:01 INFO - Fetch https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip into memory 03:37:03 INFO - Content-Length response header: 54284636 03:37:03 INFO - Bytes received: 54284636 03:37:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:37:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip 03:37:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:37:14 INFO - Fetch https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip into memory 03:37:15 INFO - Content-Length response header: 54284636 03:37:15 INFO - Bytes received: 54284636 03:37:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.talos.tests.zip 03:37:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:37:26 INFO - Fetch https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.talos.tests.zip into memory 03:37:27 INFO - Content-Length response header: 14496008 03:37:27 INFO - Bytes received: 14496008 03:37:27 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')]} 03:37:27 INFO - trying https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 03:37:27 INFO - Downloading https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:37:29 INFO - Downloaded 61835624 bytes. 03:37:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 03:37:29 INFO - mkdir: /builds/slave/test/properties 03:37:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:29 INFO - Contents: 03:37:29 INFO - build_url:https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 03:37:29 INFO - Running post-action listener: _resource_record_post_action 03:37:29 INFO - Running post-action listener: set_extra_try_arguments 03:37:29 INFO - [mozharness: 2017-08-05 10:37:29.069467Z] Finished download-and-extract step (success) 03:37:29 INFO - [mozharness: 2017-08-05 10:37:29.069566Z] Running populate-webroot step. 03:37:29 INFO - Running pre-action listener: _resource_record_pre_action 03:37:29 INFO - Running main action method: populate_webroot 03:37:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:37:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:37:29 INFO - 'tests': ['damp', 'tps']}, 03:37:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:37:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:37:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:37:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:29 INFO - 'ts_paint', 03:37:29 INFO - 'tpaint', 03:37:29 INFO - 'sessionrestore', 03:37:29 INFO - 'sessionrestore_many_windows', 03:37:29 INFO - 'sessionrestore_no_auto_restore', 03:37:29 INFO - 'tabpaint']}, 03:37:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:37:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:37:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:29 INFO - 'tsvgr_opacity', 03:37:29 INFO - 'tart', 03:37:29 INFO - 'tscrollx', 03:37:29 INFO - 'tsvg_static']}, 03:37:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:37:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:29 INFO - 'talos_options': ['--mitmproxy', 03:37:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:29 INFO - '--firstNonBlankPaint'], 03:37:29 INFO - 'tests': ['tp6_google', 03:37:29 INFO - 'tp6_youtube', 03:37:29 INFO - 'tp6_amazon', 03:37:29 INFO - 'tp6_facebook']}, 03:37:29 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:29 INFO - 'talos_options': ['--stylo', 03:37:29 INFO - '--mitmproxy', 03:37:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:29 INFO - '--firstNonBlankPaint'], 03:37:29 INFO - 'tests': ['tp6_google', 03:37:29 INFO - 'tp6_youtube', 03:37:29 INFO - 'tp6_amazon', 03:37:29 INFO - 'tp6_facebook']}, 03:37:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:29 INFO - 'talos_options': ['--stylo', 03:37:29 INFO - '--stylo-threads=1', 03:37:29 INFO - '--mitmproxy', 03:37:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:29 INFO - '--firstNonBlankPaint'], 03:37:29 INFO - 'tests': ['tp6_google', 03:37:29 INFO - 'tp6_youtube', 03:37:29 INFO - 'tp6_amazon', 03:37:29 INFO - 'tp6_facebook']}, 03:37:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:37:29 INFO - 'talos_options': ['--xperf_path', 03:37:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:29 INFO - 'tests': ['tp5n']}}} 03:37:29 INFO - Running post-action listener: _resource_record_post_action 03:37:29 INFO - [mozharness: 2017-08-05 10:37:29.077964Z] Finished populate-webroot step (success) 03:37:29 INFO - [mozharness: 2017-08-05 10:37:29.078055Z] Running create-virtualenv step. 03:37:29 INFO - Running pre-action listener: _resource_record_pre_action 03:37:29 INFO - Running main action method: create_virtualenv 03:37:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:29 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 03:37:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:37:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:29 INFO - Using real prefix '/usr' 03:37:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:29 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:31 INFO - Installing pip.................done. 03:37:31 INFO - Return code: 0 03:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:37:31 INFO - Reading from file tmpfile_stdout 03:37:31 INFO - Output received: 03:37:31 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) 03:37:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:31 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')]} 03:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:31 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')]} 03:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:31 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 03:37:31 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 03:37:31 INFO - Using env: {'DISPLAY': ':0', 03:37:31 INFO - 'HOME': '/home/cltbld', 03:37:31 INFO - 'LANG': 'en_US.UTF-8', 03:37:31 INFO - 'LANGUAGE': 'en_US:en', 03:37:31 INFO - 'LOGNAME': 'cltbld', 03:37:31 INFO - 'MAIL': '/var/mail/cltbld', 03:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:31 INFO - 'MOZ_NO_REMOTE': '1', 03:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:31 INFO - 'NO_EM_RESTART': '1', 03:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:31 INFO - 'PWD': '/builds/slave/test', 03:37:31 INFO - 'SHELL': '/bin/bash', 03:37:31 INFO - 'SHLVL': '1', 03:37:31 INFO - 'TERM': 'linux', 03:37:31 INFO - 'TMOUT': '86400', 03:37:31 INFO - 'USER': 'cltbld', 03:37:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:31 INFO - '_': '/tools/buildbot/bin/python'} 03:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:32 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 03:37:32 INFO - Cleaning up... 03:37:32 INFO - Return code: 0 03:37:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37: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')]} 03:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37: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', '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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:37: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 psutil>=3.1.1 03:37:32 INFO - Using env: {'DISPLAY': ':0', 03:37:32 INFO - 'HOME': '/home/cltbld', 03:37:32 INFO - 'LANG': 'en_US.UTF-8', 03:37:32 INFO - 'LANGUAGE': 'en_US:en', 03:37:32 INFO - 'LOGNAME': 'cltbld', 03:37:32 INFO - 'MAIL': '/var/mail/cltbld', 03:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:32 INFO - 'MOZ_NO_REMOTE': '1', 03:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:32 INFO - 'NO_EM_RESTART': '1', 03:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:32 INFO - 'PWD': '/builds/slave/test', 03:37:32 INFO - 'SHELL': '/bin/bash', 03:37:32 INFO - 'SHLVL': '1', 03:37:32 INFO - 'TERM': 'linux', 03:37:32 INFO - 'TMOUT': '86400', 03:37:32 INFO - 'USER': 'cltbld', 03:37:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:32 INFO - '_': '/tools/buildbot/bin/python'} 03:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:32 INFO - Downloading/unpacking psutil>=3.1.1 03:37:32 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 03:37:32 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 03:37:32 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 03:37:32 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 03:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:33 INFO - Installing collected packages: psutil 03:37:33 INFO - Running setup.py install for psutil 03:37:33 INFO - building 'psutil._psutil_linux' extension 03:37:33 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 03:37:33 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 03:37:33 INFO - building 'psutil._psutil_posix' extension 03:37:33 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 03:37:33 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 03:37:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:34 INFO - Successfully installed psutil 03:37:34 INFO - Cleaning up... 03:37:34 INFO - Return code: 0 03:37:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:37:34 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')]} 03:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:34 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')]} 03:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:34 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 03:37:34 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 03:37:34 INFO - Using env: {'DISPLAY': ':0', 03:37:34 INFO - 'HOME': '/home/cltbld', 03:37:34 INFO - 'LANG': 'en_US.UTF-8', 03:37:34 INFO - 'LANGUAGE': 'en_US:en', 03:37:34 INFO - 'LOGNAME': 'cltbld', 03:37:34 INFO - 'MAIL': '/var/mail/cltbld', 03:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:34 INFO - 'MOZ_NO_REMOTE': '1', 03:37:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:34 INFO - 'NO_EM_RESTART': '1', 03:37:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:34 INFO - 'PWD': '/builds/slave/test', 03:37:34 INFO - 'SHELL': '/bin/bash', 03:37:34 INFO - 'SHLVL': '1', 03:37:34 INFO - 'TERM': 'linux', 03:37:34 INFO - 'TMOUT': '86400', 03:37:34 INFO - 'USER': 'cltbld', 03:37:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:34 INFO - '_': '/tools/buildbot/bin/python'} 03:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:37:35 INFO - Installing collected packages: mozsystemmonitor 03:37:35 INFO - Running setup.py install for mozsystemmonitor 03:37:35 INFO - Successfully installed mozsystemmonitor 03:37:35 INFO - Cleaning up... 03:37:35 INFO - Return code: 0 03:37:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37:35 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')]} 03:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:35 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')]} 03:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:35 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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:35 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 03:37:35 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 03:37:35 INFO - Using env: {'DISPLAY': ':0', 03:37:35 INFO - 'HOME': '/home/cltbld', 03:37:35 INFO - 'LANG': 'en_US.UTF-8', 03:37:35 INFO - 'LANGUAGE': 'en_US:en', 03:37:35 INFO - 'LOGNAME': 'cltbld', 03:37:35 INFO - 'MAIL': '/var/mail/cltbld', 03:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:35 INFO - 'MOZ_NO_REMOTE': '1', 03:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:35 INFO - 'NO_EM_RESTART': '1', 03:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:35 INFO - 'PWD': '/builds/slave/test', 03:37:35 INFO - 'SHELL': '/bin/bash', 03:37:35 INFO - 'SHLVL': '1', 03:37:35 INFO - 'TERM': 'linux', 03:37:35 INFO - 'TMOUT': '86400', 03:37:35 INFO - 'USER': 'cltbld', 03:37:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:35 INFO - '_': '/tools/buildbot/bin/python'} 03:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:37:35 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 03:37:35 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 03:37:35 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 03:37:35 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 03:37:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:36 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:37 INFO - warning: no files found matching '*.txt' 03:37:37 INFO - no previously-included directories found matching 'build' 03:37:37 INFO - no previously-included directories found matching 'dist' 03:37:37 INFO - no previously-included directories found matching '.git*' 03:37:37 INFO - Installing collected packages: jsonschema, functools32 03:37:37 INFO - Running setup.py install for functools32 03:37:37 INFO - warning: no files found matching '*.txt' 03:37:37 INFO - no previously-included directories found matching 'build' 03:37:37 INFO - no previously-included directories found matching 'dist' 03:37:37 INFO - no previously-included directories found matching '.git*' 03:37:37 INFO - Successfully installed jsonschema functools32 03:37:37 INFO - Cleaning up... 03:37:37 INFO - Return code: 0 03:37:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:37 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')]} 03:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:37 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')]} 03:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:37 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 03:37:37 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 03:37:37 INFO - Using env: {'DISPLAY': ':0', 03:37:37 INFO - 'HOME': '/home/cltbld', 03:37:37 INFO - 'LANG': 'en_US.UTF-8', 03:37:37 INFO - 'LANGUAGE': 'en_US:en', 03:37:37 INFO - 'LOGNAME': 'cltbld', 03:37:37 INFO - 'MAIL': '/var/mail/cltbld', 03:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:37 INFO - 'MOZ_NO_REMOTE': '1', 03:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:37 INFO - 'NO_EM_RESTART': '1', 03:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:37 INFO - 'PWD': '/builds/slave/test', 03:37:37 INFO - 'SHELL': '/bin/bash', 03:37:37 INFO - 'SHLVL': '1', 03:37:37 INFO - 'TERM': 'linux', 03:37:37 INFO - 'TMOUT': '86400', 03:37:37 INFO - 'USER': 'cltbld', 03:37:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:37 INFO - '_': '/tools/buildbot/bin/python'} 03:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:37 INFO - Cleaning up... 03:37:37 INFO - Return code: 0 03:37:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:37 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')]} 03:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:37 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')]} 03:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:37 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 03:37:37 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 03:37:37 INFO - Using env: {'DISPLAY': ':0', 03:37:37 INFO - 'HOME': '/home/cltbld', 03:37:37 INFO - 'LANG': 'en_US.UTF-8', 03:37:37 INFO - 'LANGUAGE': 'en_US:en', 03:37:37 INFO - 'LOGNAME': 'cltbld', 03:37:37 INFO - 'MAIL': '/var/mail/cltbld', 03:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:37 INFO - 'MOZ_NO_REMOTE': '1', 03:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:37 INFO - 'NO_EM_RESTART': '1', 03:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:37 INFO - 'PWD': '/builds/slave/test', 03:37:37 INFO - 'SHELL': '/bin/bash', 03:37:37 INFO - 'SHLVL': '1', 03:37:37 INFO - 'TERM': 'linux', 03:37:37 INFO - 'TMOUT': '86400', 03:37:37 INFO - 'USER': 'cltbld', 03:37:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:37 INFO - '_': '/tools/buildbot/bin/python'} 03:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:37 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:38 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:39 INFO - Downloading docopt-0.6.1.tar.gz 03:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:39 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:39 INFO - Running setup.py install for blobuploader 03:37:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:39 INFO - Running setup.py install for requests 03:37:40 INFO - Running setup.py install for docopt 03:37:40 INFO - Successfully installed blobuploader requests docopt 03:37:40 INFO - Cleaning up... 03:37:40 INFO - Return code: 0 03:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:40 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')]} 03:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:40 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')]} 03:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:40 INFO - Using env: {'DISPLAY': ':0', 03:37:40 INFO - 'HOME': '/home/cltbld', 03:37:40 INFO - 'LANG': 'en_US.UTF-8', 03:37:40 INFO - 'LANGUAGE': 'en_US:en', 03:37:40 INFO - 'LOGNAME': 'cltbld', 03:37:40 INFO - 'MAIL': '/var/mail/cltbld', 03:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:40 INFO - 'MOZ_NO_REMOTE': '1', 03:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:40 INFO - 'NO_EM_RESTART': '1', 03:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:40 INFO - 'PWD': '/builds/slave/test', 03:37:40 INFO - 'SHELL': '/bin/bash', 03:37:40 INFO - 'SHLVL': '1', 03:37:40 INFO - 'TERM': 'linux', 03:37:40 INFO - 'TMOUT': '86400', 03:37:40 INFO - 'USER': 'cltbld', 03:37:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:40 INFO - '_': '/tools/buildbot/bin/python'} 03:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:40 INFO - Running setup.py (path:/tmp/pip-nRyjhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:40 INFO - Running setup.py (path:/tmp/pip-0FssVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:40 INFO - Running setup.py (path:/tmp/pip-p0YR3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:40 INFO - Running setup.py (path:/tmp/pip-yE7cZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:40 INFO - Running setup.py (path:/tmp/pip-vodrCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:40 INFO - Running setup.py (path:/tmp/pip-0JaB0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:41 INFO - Running setup.py (path:/tmp/pip-hMSN1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:41 INFO - Running setup.py (path:/tmp/pip-ROHc_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:41 INFO - Running setup.py (path:/tmp/pip-Q2wQaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:41 INFO - Running setup.py (path:/tmp/pip-9qFDsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:41 INFO - Running setup.py (path:/tmp/pip-FQ2Qku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:41 INFO - Running setup.py (path:/tmp/pip-XhHE_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:41 INFO - Running setup.py (path:/tmp/pip-Hm_hRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:41 INFO - Running setup.py (path:/tmp/pip-PDtvW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:41 INFO - Running setup.py (path:/tmp/pip-XQE7tA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:41 INFO - Running setup.py (path:/tmp/pip-pL3_55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:41 INFO - Running setup.py (path:/tmp/pip-cSaC7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:41 INFO - Running setup.py install for manifestparser 03:37:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:41 INFO - Running setup.py install for mozcrash 03:37:41 INFO - Running setup.py install for mozdebug 03:37:42 INFO - Running setup.py install for mozdevice 03:37:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for mozfile 03:37:42 INFO - Running setup.py install for mozhttpd 03:37:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for mozinfo 03:37:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for mozInstall 03:37:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for mozleak 03:37:42 INFO - Running setup.py install for mozlog 03:37:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for moznetwork 03:37:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for mozprocess 03:37:43 INFO - Running setup.py install for mozprofile 03:37:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:43 INFO - Running setup.py install for mozrunner 03:37:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:43 INFO - Running setup.py install for mozscreenshot 03:37:43 INFO - Running setup.py install for moztest 03:37:43 INFO - Running setup.py install for mozversion 03:37:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:43 INFO - Cleaning up... 03:37:43 INFO - Return code: 0 03:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:43 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')]} 03:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:43 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')]} 03:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:37:43 INFO - Using env: {'DISPLAY': ':0', 03:37:43 INFO - 'HOME': '/home/cltbld', 03:37:43 INFO - 'LANG': 'en_US.UTF-8', 03:37:43 INFO - 'LANGUAGE': 'en_US:en', 03:37:43 INFO - 'LOGNAME': 'cltbld', 03:37:43 INFO - 'MAIL': '/var/mail/cltbld', 03:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:43 INFO - 'MOZ_NO_REMOTE': '1', 03:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:43 INFO - 'NO_EM_RESTART': '1', 03:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:43 INFO - 'PWD': '/builds/slave/test', 03:37:43 INFO - 'SHELL': '/bin/bash', 03:37:43 INFO - 'SHLVL': '1', 03:37:43 INFO - 'TERM': 'linux', 03:37:43 INFO - 'TMOUT': '86400', 03:37:43 INFO - 'USER': 'cltbld', 03:37:43 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:43 INFO - '_': '/tools/buildbot/bin/python'} 03:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:43 INFO - Running setup.py (path:/tmp/pip-gp7aSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:43 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)) 03:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:43 INFO - Running setup.py (path:/tmp/pip-8R1dFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:43 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)) 03:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:43 INFO - Running setup.py (path:/tmp/pip-jdNsCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:44 INFO - Running setup.py (path:/tmp/pip-myVSnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:44 INFO - Running setup.py (path:/tmp/pip-qUEXt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:44 INFO - Running setup.py (path:/tmp/pip-f5RR43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:44 INFO - Running setup.py (path:/tmp/pip-77aKYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:44 INFO - Running setup.py (path:/tmp/pip-Z2AYMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:44 INFO - Running setup.py (path:/tmp/pip-5sBYri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:44 INFO - Running setup.py (path:/tmp/pip-J4x9mK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:44 INFO - Running setup.py (path:/tmp/pip-fm4Mw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:44 INFO - Running setup.py (path:/tmp/pip-lNeqHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:44 INFO - Running setup.py (path:/tmp/pip-xsnZ7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:44 INFO - Running setup.py (path:/tmp/pip-PziFYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:44 INFO - Running setup.py (path:/tmp/pip-CBWJ4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:44 INFO - Running setup.py (path:/tmp/pip-3IYveK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:44 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)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:44 INFO - Running setup.py (path:/tmp/pip-TJ6e0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:45 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)) 03:37:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:46 INFO - Downloading blessings-1.6.tar.gz 03:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:46 INFO - Installing collected packages: blessings 03:37:46 INFO - Running setup.py install for blessings 03:37:46 INFO - Successfully installed blessings 03:37:46 INFO - Cleaning up... 03:37:46 INFO - Return code: 0 03:37:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:46 INFO - Reading from file tmpfile_stdout 03:37:46 INFO - Current package versions: 03:37:46 INFO - argparse == 1.2.1 03:37:46 INFO - blessings == 1.6 03:37:46 INFO - blobuploader == 1.2.4 03:37:46 INFO - docopt == 0.6.1 03:37:46 INFO - functools32 == 3.2.3-2 03:37:46 INFO - jsonschema == 2.5.1 03:37:46 INFO - manifestparser == 1.1 03:37:46 INFO - mozInstall == 1.13 03:37:46 INFO - mozcrash == 1.0 03:37:46 INFO - mozdebug == 0.1 03:37:46 INFO - mozdevice == 0.51 03:37:46 INFO - mozfile == 1.2 03:37:46 INFO - mozhttpd == 0.7 03:37:46 INFO - mozinfo == 0.10 03:37:46 INFO - mozleak == 0.1 03:37:46 INFO - mozlog == 3.5 03:37:46 INFO - moznetwork == 0.27 03:37:46 INFO - mozprocess == 0.25 03:37:46 INFO - mozprofile == 0.28 03:37:46 INFO - mozrunner == 6.13 03:37:46 INFO - mozscreenshot == 0.1 03:37:46 INFO - mozsystemmonitor == 0.3 03:37:46 INFO - moztest == 0.8 03:37:46 INFO - mozversion == 1.4 03:37:46 INFO - psutil == 3.1.1 03:37:46 INFO - requests == 1.2.3 03:37:46 INFO - wsgiref == 0.1.2 03:37:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:46 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')]} 03:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:46 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')]} 03:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:46 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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:46 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 03:37:46 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 03:37:46 INFO - Using env: {'DISPLAY': ':0', 03:37:46 INFO - 'HOME': '/home/cltbld', 03:37:46 INFO - 'LANG': 'en_US.UTF-8', 03:37:46 INFO - 'LANGUAGE': 'en_US:en', 03:37:46 INFO - 'LOGNAME': 'cltbld', 03:37:46 INFO - 'MAIL': '/var/mail/cltbld', 03:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:46 INFO - 'MOZ_NO_REMOTE': '1', 03:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:46 INFO - 'NO_EM_RESTART': '1', 03:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:46 INFO - 'PWD': '/builds/slave/test', 03:37:46 INFO - 'SHELL': '/bin/bash', 03:37:46 INFO - 'SHLVL': '1', 03:37:46 INFO - 'TERM': 'linux', 03:37:46 INFO - 'TMOUT': '86400', 03:37:46 INFO - 'USER': 'cltbld', 03:37:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:46 INFO - '_': '/tools/buildbot/bin/python'} 03:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 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)) 03:37:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:37:46 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 03:37:46 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 03:37:46 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 03:37:46 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 03:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:37:48 INFO - Installing collected packages: simplejson 03:37:48 INFO - Running setup.py install for simplejson 03:37:48 INFO - building 'simplejson._speedups' extension 03:37:48 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 03:37:48 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 03:37:49 INFO - Successfully installed simplejson 03:37:49 INFO - Cleaning up... 03:37:49 INFO - Return code: 0 03:37:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:49 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')]} 03:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:49 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')]} 03:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:49 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 0x1cb91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e86a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2029d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, '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-1501917258.600740-194931230', '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 03:37:49 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 03:37:49 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 03:37:49 INFO - Using env: {'DISPLAY': ':0', 03:37:49 INFO - 'HOME': '/home/cltbld', 03:37:49 INFO - 'LANG': 'en_US.UTF-8', 03:37:49 INFO - 'LANGUAGE': 'en_US:en', 03:37:49 INFO - 'LOGNAME': 'cltbld', 03:37:49 INFO - 'MAIL': '/var/mail/cltbld', 03:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:49 INFO - 'MOZ_NO_REMOTE': '1', 03:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:49 INFO - 'NO_EM_RESTART': '1', 03:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:49 INFO - 'PWD': '/builds/slave/test', 03:37:49 INFO - 'SHELL': '/bin/bash', 03:37:49 INFO - 'SHLVL': '1', 03:37:49 INFO - 'TERM': 'linux', 03:37:49 INFO - 'TMOUT': '86400', 03:37:49 INFO - 'USER': 'cltbld', 03:37:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:49 INFO - '_': '/tools/buildbot/bin/python'} 03:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:49 INFO - Cleaning up... 03:37:49 INFO - Return code: 0 03:37:49 INFO - Running post-action listener: _resource_record_post_action 03:37:49 INFO - Running post-action listener: _start_resource_monitoring 03:37:49 INFO - Starting resource monitoring. 03:37:49 INFO - [mozharness: 2017-08-05 10:37:49.306787Z] Finished create-virtualenv step (success) 03:37:49 INFO - [mozharness: 2017-08-05 10:37:49.307262Z] Running install step. 03:37:49 INFO - Running pre-action listener: _resource_record_pre_action 03:37:49 INFO - Running main action method: install 03:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:49 INFO - Reading from file tmpfile_stdout 03:37:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:49 INFO - Reading from file tmpfile_stdout 03:37:49 INFO - Output received: 03:37:49 INFO - Usage: mozinstall [options] installer 03:37:49 INFO - Options: 03:37:49 INFO - -h, --help show this help message and exit 03:37:49 INFO - -d DEST, --destination=DEST 03:37:49 INFO - Directory to install application into. [default: 03:37:49 INFO - "/builds/slave/test"] 03:37:49 INFO - --app=APP Application being installed. [default: firefox] 03:37:49 INFO - mkdir: /builds/slave/test/build/application 03:37:49 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'] 03:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:38:07 INFO - Reading from file tmpfile_stdout 03:38:07 INFO - Output received: 03:38:07 INFO - /builds/slave/test/build/application/firefox/firefox 03:38:07 INFO - Running post-action listener: _resource_record_post_action 03:38:07 INFO - [mozharness: 2017-08-05 10:38:07.665295Z] Finished install step (success) 03:38:07 INFO - [mozharness: 2017-08-05 10:38:07.665574Z] Running setup-mitmproxy step. 03:38:07 INFO - Running pre-action listener: _resource_record_pre_action 03:38:07 INFO - Running main action method: setup_mitmproxy 03:38:07 INFO - Skipping: mitmproxy is not required 03:38:07 INFO - Running post-action listener: _resource_record_post_action 03:38:07 INFO - [mozharness: 2017-08-05 10:38:07.666714Z] Finished setup-mitmproxy step (success) 03:38:07 INFO - [mozharness: 2017-08-05 10:38:07.666933Z] Running run-tests step. 03:38:07 INFO - Running pre-action listener: _resource_record_pre_action 03:38:07 INFO - Running pre-action listener: _set_gcov_prefix 03:38:07 INFO - Running main action method: run_tests 03:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:07 INFO - Python 2.7.3 03:38:07 INFO - Return code: 0 03:38:07 INFO - grabbing minidump binary from tooltool 03:38:07 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')]} 03:38:07 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 0x2026eb0>, '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 0x2027db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2028240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:07 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 03:38:07 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 03:38:07 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 03:38:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:07 INFO - Return code: 0 03:38:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:38:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:07 INFO - ENV: RUST_BACKTRACE is now 1 03:38:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:38:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:07 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/KWzyzWIlQJ2iudAWGgv8fQ/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 03:38:07 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/KWzyzWIlQJ2iudAWGgv8fQ/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 03:38:07 INFO - Using env: {'DISPLAY': ':0', 03:38:07 INFO - 'HOME': '/home/cltbld', 03:38:07 INFO - 'LANG': 'en_US.UTF-8', 03:38:07 INFO - 'LANGUAGE': 'en_US:en', 03:38:07 INFO - 'LOGNAME': 'cltbld', 03:38:07 INFO - 'MAIL': '/var/mail/cltbld', 03:38:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:07 INFO - 'MOZ_NO_REMOTE': '1', 03:38:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:38:07 INFO - 'NO_EM_RESTART': '1', 03:38:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:07 INFO - 'PWD': '/builds/slave/test', 03:38:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:07 INFO - 'RUST_BACKTRACE': '1', 03:38:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:38:07 INFO - 'SHELL': '/bin/bash', 03:38:07 INFO - 'SHLVL': '1', 03:38:07 INFO - 'TERM': 'linux', 03:38:07 INFO - 'TMOUT': '86400', 03:38:07 INFO - 'USER': 'cltbld', 03:38:07 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1501917258.600740-194931230', 03:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:07 INFO - '_': '/tools/buildbot/bin/python'} 03:38:07 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/KWzyzWIlQJ2iudAWGgv8fQ/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 03:38:08 INFO - mozversion application_buildid: 20170805095303 03:38:08 INFO - mozversion application_changeset: a9182f92641b24d0a972886aed27e784004a343f 03:38:08 INFO - mozversion application_display_name: Nightly 03:38:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:08 INFO - mozversion application_name: Firefox 03:38:08 INFO - mozversion application_remotingname: firefox 03:38:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:38:08 INFO - mozversion application_vendor: Mozilla 03:38:08 INFO - mozversion application_version: 57.0a1 03:38:08 INFO - mozversion platform_buildid: 20170805095303 03:38:08 INFO - mozversion platform_changeset: a9182f92641b24d0a972886aed27e784004a343f 03:38:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:38:08 INFO - mozversion platform_version: 57.0a1 03:38:08 INFO - using testdate: 1501929488 03:38:08 INFO - actual date: 1501929488 03:38:08 INFO - starting webserver on 'localhost:36395' 03:38:08 INFO - SUITE-START | Running 2 tests 03:38:08 INFO - TEST-START | dromaeo_css 03:38:08 INFO - Initialising browser for dromaeo_css test... 03:38:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36395/getInfo.html -profile /tmp/tmpM1gRYk/profile 03:38:08 INFO - TEST-INFO | started process 7939 (/builds/slave/test/build/application/firefox/firefox http://localhost:36395/getInfo.html) 03:38:14 INFO - TEST-INFO | 7939: exit 0 03:38:14 INFO - Browser initialized. 03:38:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:14 INFO - TEST-INFO | started process 8147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM1gRYk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:15 INFO - PID 8147 | 03:38:15 INFO - PID 8147 | (/builds/slave/test/build/application/firefox/firefox:8195): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:15 INFO - PID 8147 | 03:38:25 INFO - PID 8147 | RSS: Main: 170721280 03:38:25 INFO - PID 8147 | 03:41:25 INFO - PID 8147 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36395/tests/dromaeo/cssquery-ext.html) 03:41:26 INFO - PID 8147 | RSS: Main: 172879872 03:41:26 INFO - PID 8147 | 03:44:28 INFO - PID 8147 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-ext.html (next: http://localhost:36395/tests/dromaeo/cssquery-jquery.html) 03:44:29 INFO - PID 8147 | RSS: Main: 168558592 03:44:29 INFO - PID 8147 | 03:47:30 INFO - PID 8147 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36395/tests/dromaeo/cssquery-mootools.html) 03:47:31 INFO - PID 8147 | RSS: Main: 172548096 03:47:31 INFO - PID 8147 | 03:50:33 INFO - PID 8147 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36395/tests/dromaeo/cssquery-prototype.html) 03:50:33 INFO - PID 8147 | RSS: Main: 171347968 03:50:33 INFO - PID 8147 | 03:53:37 INFO - PID 8147 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36395/tests/dromaeo/cssquery-yui.html) 03:53:37 INFO - PID 8147 | RSS: Main: 174342144 03:53:37 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | Cycle 1(1): loaded http://localhost:36395/tests/dromaeo/cssquery-yui.html (next: http://localhost:36395/tests/dromaeo/cssquery-dojo.html) 03:56:39 INFO - PID 8147 | RSS: Main: 175185920 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | __start_tp_report 03:56:39 INFO - PID 8147 | _x_x_mozilla_page_load 03:56:39 INFO - PID 8147 | _x_x_mozilla_page_load_details 03:56:39 INFO - PID 8147 | |i|pagename|runs| 03:56:39 INFO - PID 8147 | |0;dojo.html;3144.4811606084995;3171.3498732759786;3173.508106243533;3189.1867573768686;3212.3414699986492;6187.257529096503;6263.780767673133;6273.686315684215;6307.842303942403;6359.8092057238355;6115.235595550556;6211.130441738149;6231.719572619231;6232.844178895519;6260.906086408696;5689.544836413098;5694.886102277962;5726.198332233491;5727.541796656278;5767.625104368223;5691.715414229293;5726.055200891848;5740.225069615611;5741.33974592923;5749.252597162363;5715.599908006441;5771.105478650816;5783.797567085153;5802.854928626776;5822.737976791054;5696.487316141567;5726.112452569859;5774.88450230993;5797.855053623651;5858.76564937402;5283.709395983219;5551.750171242264;5641;5711.571632127566;5715.399883012307;6150.7847225346895;6152.292486364081;6191.504679625619;6261.154744109578;6265.655388953605;6574.211094668671;6647.6011439313315;6670.3329667033395;6693.866122677568;6699.263081061079;6573.30980247072;6672.733090676367;6686.264510903797;6699.631520266384;6804.08144900437;6119.44924956756;6132.41742034506;6139.938600614026;6158.846028849225;6200.906986395207;6899.93100069003;6957.82605434858;6959.060526828915;6961.860762784716;6963.547369420971;6533.150690410312;6596.604203747695;6662.700178491883;6663.36698013688;6672.266050734415;6681.766138185238;6710.664466776641;6783.559068660521;6787.083743694538;6814.352636499525;6585.637789921505;6660.367265109807;6693.230278517935;6780.525363224626;6793.762218322335;6672;6719.798406047827;6778.830529236809;6788.1175447191545;6814.727410903508;5482.013237617267;5534.142207957773;5545.805896793593;5547.77808887648;5557.472040156179;4670.7664616769025;4689.577937985598;4706.552877476634;4727.2909063640045;4754.120487709784;5766.913496297559;5833.854153646108;5896.292444906639;5904.261967254093;5911.527077833763;6781.6609169541325;6788.558743681645;6789.422899053537;6793.082933803873;6796.184457865088;5816.505597024216;5860.033094539439;5873.911891321633;5878.059510478303;5890.175375447441;5848.466998792027;5921.822345329647;6006.729697163551;6013.51891848651;6016.639001659914;6387.648679322682;6494.318096599789;6499.902501462388;6579.506537009744;6605.504587155887;6723.663816809238;6754.628495432798;6755.256921738506;6755.459563235027;6765.154355705537;6443.484521238383;6502.252240992347;6538.1827271591055;6544.509161812788;6545.639989800607;6552.967235163794;6631;6638.302978187221;6642.501812363996;6644.634545100066;6841.897371539331;6852.45180385558;6858.2455929848675;6870;6885.2770459101075;6521.543491955707;6547.639879806657;6615.338466153346;6616.239132499824;6619.172603424572;6524.119243902012;6529.281779004211;6602.042703807825;6629.734810607714;6630.46956243509;6276;6311.431971122621;6367.044943258548;6373.6175829450385;6378.394052564999;6466.741330346734;6467.191601049869;6555.4427873631275;6563.048357987969;6582.506312026713;6157.630542167484;6382.106505089198;6400;6498.610083395011;6499.122618446449 03:56:39 INFO - PID 8147 | |1;ext.html;771.7183228121737;804.9637766300516;856.7215654912153;1145.4101137913976;1179.4456605395471;29450;40026.59973400265;40886.99999999996;40970.180596388054;40991;40683.59316406835;40695.186096278056;40830.387544186786;41070;41100.38349424761;7203.89194162088;7541.924580754205;7820.374370050411;7827.804304892366;7843.843123137533;7623.885641715378;7725.18885517021;7727.38180945523;7728.072631284225;7732;7728.961355193244;7738.961305193466;7778.4166187535875;7784.805379865492;7785.299323060924;7709.151993280735;7711.691532338699;7743.651535680908;7748.1864404237585;7750.302472777449;7565.319121279056;7575;7624.847503049908;7642.8089297768;7643;37862.43206351879;37864.24271514554;37944.62055379466;38024.23951520982;38050.238995220214;3488.0407887830797;3535;3539.327527769741;3583.516225309576;3594.730395220343;30285;30544;30554;30563.694363056307;30598.69401306003;4696.530346965276;4950.529699678561;4981.178105612569;4996.1756310208775;5035.62232832539;190474;190828;191500;191718;192607;47971.76014119907;48132.5186748128;48266.75866620644;48319.75840120847;48402;50568.49431505711;50745;51009.744951275745;51058.74470627697;51109.48890511122;13285;15351.616209594626;15600.14199219031;15643;15659.686806263811;11057.834132488018;11138.832917506244;11316.37759923212;11323.603673871376;11328.660140195807;13388.464461421434;13399;13466.259355735332;13531.255780931946;13661.248631325372;5403.8108666196495;5486.1770734389365;5562.221289019541;5568.303962004749;5700.8859822803315;970.4953424219366;987.9851802222972;998.960041598328;1009.3035805294323;1009.9697009089739;22342.21802236914;22458.550828983654;22568.887155564116;22657.433564161027;22701.545969080857;1085.5386460754148;1098.8406681031206;1114.3870871020906;1114.9163812713916;1119.5857532712785;11837.644870653894;11877.168598198215;12013.219140755822;12046.51813927433;12114.939425302993;221812;223446;223450;223582;224531.63202551974;51308.23037654438;51359.22961155586;51636;51673.224901626505;51695.741521292155;1398.3288021749618;1440.287057906343;1443.9100325303648;1448.174540511919;1473.2191938272733;22191.667124992815;22449;22459.213927512457;22597.2090976815;22791.65812512847;36048.27903441969;36169;36174.63825361818;36189.63810361968;36247.818760906026;184563.0771846132;184696;184764;185307;185466;32233.838830805696;32752;33993.490097649046;34721.47917781286;34747.478787817694;44610.10779784451;45326.54673453223;45608.77195614001;45779.54220457886;45991.77004114958;33404;33596.83201583976;33967.49048764221;34031.638734450346;34266.14334641654;32129.839350803097;32762.672373275964;32897.50653740148;33523.83238083794;33939.66060339365;35564.11089722778;35910.8204458976;36338.81830590936;36576.26847463089;36582.63417365792;31809.204769880937;31949.36101277915;32056.83971580127;32191.195220119684;32923.835380822944;23864;23956.281311559986;24459.38851528726;24577.50844983126;24637.630435543124 03:56:39 INFO - PID 8147 | |2;jquery.html;571.8741876787108;588.4733163818386;590.5452801342966;596.296370283066;597.7818096394816;20173.39479815604;21107.2612458564;21110.366688999355;21136.57726845462;22492.550148997012;27138.72861271387;27779.722202778015;27795.305117372074;27809;27914.441711165815;6406.199225096863;6482.092507049017;6535.934640653604;6589.439897608709;6589.868202635945;5911.793087241947;6503.089567460559;6504.869902601945;6518.771842985473;6525.3800888915475;6479.967600161993;6486.870262594745;6489.0266460031135;6490.772822951198;6503.544751867371;6476.708548115346;6498.772542960974;6499.1876015498065;6507.186601674791;6507.739690412425;5969.343372229051;6066.393360663942;6074.119252708377;6075.179850720185;6085.726142323606;29179.270518237;29607.70392296071;30248.243793905327;30431;30443.543346849816;1800.126938434858;1851.018959951228;1851.3797877710983;1851.3797877710983;1860.283790740561;18776.15507302161;19335.226590936345;19469.221231150736;19532.31636892702;19543.80456195434;2412.7587241275905;2431.805455563551;2440.6583078369044;2508.7240403555593;2512.522620702061;129241;131263;131284.6871531282;131308;132458;14380.424783008562;14743.262836858114;15256.313465894062;15472.839537034542;15695.68608627821;24183.637245441332;24208.394790130387;24235.272941811774;24250.15124470635;24282.635760463607;9837.213022958289;10010.649627263156;10029.147522460527;10070.144037756872;10191.94904025475;7307.415406767446;9137.63449462014;9166.587503562356;9325.347225694271;9334.906650933404;8071.354291656653;9231.169194772503;9477.715668529818;9506.144446999664;9583.377080489747;2753.0914798116573;2762.8894844206407;2777.569626576745;2784.4013537089622;2861.957070643942;932.7481579973369;964.4599024546277;975.2929126383316;994.5325696922434;996.8853581838182;19573.510662233275;19742.802571974386;19789.30737424183;20218.797812021985;20445.591088178153;1018.7707765752647;1024.349538043333;1031.1029404418205;1035.2442716816615;1037.9636712715019;10983.231173817756;11165.497552610152;11169.553217871195;11176.441177941071;11200.943995279971;468503;511434;513898;529740;537664;112962.43518782518;114165;118212.40893795477;118388.63222735497;119322.4033879825;1164.930104193751;1193.8985186259265;1203.915725899196;1204.2292932523017;1208.0335731414832;17757.822421776134;17957.371491997717;18002.729959050364;18166.182521786286;18173;56276.43723562876;57399.71300143473;57789.133163001745;58297;58333.416665832796;70806.6459667719;71137.64431177812;71726.64136679283;71779.28220717725;73368.26631733614;12199.14605977573;12799.42402591867;13259.337033148111;14412.13527188372;14745.336459859118;23029.193978210682;23084.307470775904;23139;23397.298081057597;23406.18078367249;18365.54086147857;18645.440636780917;18656.16047277903;18703.625927481648;19067.141978611275;16405;16857.15714214309;16921.661566768842;17391.391301304393;17518.211680474153;18184;18950.620987580445;19175.712364314826;19196.040197989765;19197.424077277705;14656.120632762068;14680.853191468375;14736.705265894409;14749;14765.187914664366;18444.07779611041;18611.162497687365;18614.81385186131;18625.627487450445;18868.43394698161 03:56:39 INFO - PID 8147 | |3;mootools.html;1331.893448524118;1370.5340184337324;1389.0554422992368;1393.8884889208864;1403.9859601403982;13572.728545429085;14113.858861411383;14207.78688319676;14221.07563008405;14229.78655320171;13574.18554886705;14015.859841401583;14022.859771402309;14026.43894244229;14083.647908802284;2507.1601013660447;2533.6326232696247;2536.7843733282693;2543.504016716741;2552.3619095226195;2442.0598069743187;2445.1686426614947;2491.8878650460774;2563.9487210255784;2668.3996100877243;2491.302435318114;2533.2526904563197;2534.6451496790464;2535.8098142639283;2539.9492010159784;2278.2481781012225;2283.6574513822893;2292.873891935943;2297.6208925527267;2300.114455934477;2378.084437491561;2404.9639255411007;2421.6488609151575;2429.2105065853666;2429.7691719286818;13759.587212383645;13800.585982420544;13950.162990220519;14008.369623366973;14066.367013484418;7293.124825021031;7529.661165247522;7530.510516816389;7546.2831031051965;7571.432142589328;4967.304577359173;4993.85141417476;5111.514406131411;5168.302279192299;5179.922301165486;1816.4459839748872;1828.414907229687;1829.0945981739123;1875.756151700284;1879.2858713688847;23078.884605577034;23282.53434931309;23291.06835726569;23334.64998025031;23341.066357345684;5933.3473317934995;6027.306859711101;6234.2830574483605;6273.215848018997;6273.8745225095245;15693.529194124194;15693.764593531107;15697.21513924322;15723.371065157266;15730.292136853868;7118.71525138999;7261.564306141649;7360.33756961876;7364.631768411665;7367.5579465231185;6353.269374022047;6642.800715978528;6812.93187068123;6866.896996545056;6919.238883722786;4676.18166820805;4884.584810291165;4903.33804936329;4904.337914381513;4904.681195722338;1297.4031945305264;1318.1234479071502;1382.5022991723172;1393.3451277899371;1448.4133925760084;892.4422236102436;897.6678628907346;901.89517840646;910.8588168833709;923.3582660051334;8257.091719910804;8295;8298.128696486781;8401.789955251168;8470.66117355299;974.2060220919927;986.4081551069445;987.0721521769657;987.8567607696843;992.4690290694443;4851.757412129379;4932;4982.402111746614;5061.544460998454;5128.487151284916;19282.8071719281;19952.10215540275;19957.900210498854;20083.397498075083;20167.697484537744;19150.138243779063;19535.902320488305;19913;19944;19985.500362490762;10759.139268858473;11071.391073491035;11099.944500277608;11114;11117.27737697047;7458.664360103699;7916.972722321252;7930.405219608437;7955.323797477279;8055.556944368116;16721.414750483676;16971.490855274362;17383.391581294592;17462.30150793954;17531.474055778348;17675.823241767932;17725.73411398804;17884.195211215265;18002.819971800116;18023.2790688371;10034.949825250827;10090.8486372703;10183.694489165337;10190.567507640666;10250.743731406774;13008.544700935421;13133.146345487512;13188.010899182407;13196.868031319564;13213.273269969859;10879.401632910265;10945.726356840823;11191.608293709682;11213.831792522955;11326.830097548378;10259.307214309556;10308.948455257676;10326.432046237529;10378.273520853469;10598.20513461478;9075.410098343587;9318.72043838686;9373.297002724687;9532;9682.56428460735;7230;7242.89135662955;7304.598247096461;7347.302006309392;7365.484416091036;7264.854702906018;7284.307990740871;7322.0847394075745;7322.304381083789;7370.5946172961 03:56:39 INFO - PID 8147 | |4;prototype.html;460.222224440695;476.2451514349755;495.36840528326377;499.20127795527156;501.6513523101446;6154.69226538673;6209.9068513972325;6234.438900498954;6243.594166379182;6261.592996455227;5931.258592675916;6067.237218783256;6067.817965461032;6071.908921366172;6083.498211323622;4832.64685887952;4846.515348465161;4861.538153875394;4886.53577910098;4896.314515967767;4821.733785120988;4823.614110871139;4854.393200849894;4863;4883.12103821312;4857.781399837016;4864.854054378375;4874.2444921037295;4879.804807807701;4889.559939605435;4842.443119041285;4856.781444834991;4864.854054378375;4888.266759985995;4901.166801643729;4344.478662560481;4353.564643535653;4378.496472905625;4409.883256037088;4424.84513042042;5938.853286848134;5967.313758917737;6089.330173680892;6095.207623009025;6100.420460056288;5522.144067669517;5589.189567512688;5589.528377298186;5613.578981576398;5627.54979601635;6330.366963303679;6371.55399122057;6388.936110638881;6428.753479492873;6458.515611329169;4769.546893045155;4774.188387974053;4795.112904112751;4830.637702172316;4847.418309802846;6751.324867513258;6799.796006119825;6839.7428848479385;6843.8973415398805;6872.62200578968;4763.73799441034;4854.393200849894;4865.659403841768;4878.902421951541;4908.9263661045115;4923.01539692063;4946.9010619787405;4962.280469331927;4972.179590367549;5007.273945277987;5528.778848846082;5561.277033985556;5612.494875461228;5618.550515958714;5659.3208814941645;6465;6494.577852439576;6522.032475223857;6543.247526534415;6562.5406221564035;1632.2736382309995;1640.270079814471;1688.8311168883258;1702.4296860551854;1728.7666165067806;1153.7577108807245;1155.624422062833;1176.8999635031118;1182.6924999500193;1186.3415804228737;5615.932972735167;5647.29408823897;5683.232763576947;5702.6863522506665;5710.514606258432;6376.776812811529;6487.610743355413;6694.55648688235;6725.982205338379;6762.526623136333;5693.17448969897;5704.714764261853;5749.223854779551;5777.220075289866;5814.563907706939;3476.495908093312;3491.2493813830147;3528.259065596202;3537.727601968169;3565.286942611488;6388.456981156561;6419.133416988647;6478.643674597943;6481.5138864584405;6484.643344615997;6771.715717876924;6789.830254243683;6811.956413076057;6866.862662746817;6916.135483064617;6372.745090196433;6410.743570257137;6446.806595802133;6492.513061520311;6506.804795856132;6558.672066396565;6591.14315139048;6604.174478190226;6639.601623902581;6726.7981960541265;6579.671016449254;6581.308962558863;6582.80251592453;6666.333366663489;6703.597784132772;6362.918303888443;6444.9355506444335;6461.935380646133;6469.644169570531;6496.870062598627;4848.272759086165;4855.878603034952;4882.462929077869;4888.682235654814;4894.898647804358;6434.613923164625;6612.966935165294;6724.798256052326;6739.528233023641;6762.4928130389435;6336.493080553452;6408.58344207625;6482.805515834532;6528.183977002875;6543;6451.935480645134;6452.548321617442;6505.837354066186;6512.54412191161;6553.2136143663065;6312.873742525032;6341.8097457076365;6352.06262090067;6391.169148010915;6425.935740642533;6316.936830631635;6448.29068802422;6498.480121590167;6560.950247960303;6585.769498067544;6236.314005459487;6270.212989298028;6337.429631333202;6341.239051313872;6349.650769207553 03:56:39 INFO - PID 8147 | |5;yui.html;842.0611018714136;873.6287077991852;879.8196369744203;900.4597241655007;921.7188757428981;18464.723029154557;19752;19768.30810921618;19782.10980505877;20964.580708385824;21364.4658883528;21793.891030544866;21837.890810545927;22087.226947056857;22229.55540889181;1002.854586085019;1052.431686889079;1053.699695586758;1054.1356088007838;1054.6256079091927;1019.4393083803915;1059.3061544688242;1067.3062509368895;1069.4332004037833;1070.882202957674;1107.2581370481796;1120.7254222715446;1122.4892673833385;1123.365298606289;1123.5898896902654;1115.041064684371;1118.2116607791488;1119.367557330106;1119.6361182615601;1121.4000509727298;817.7587611654576;820.4093053001889;821.5440430561036;822.6051495282298;822.786075620337;19848.90075549613;19942.401727948185;20359.185632574678;20390.79609203904;20730.896345518326;21285.893570532204;21793.564128717495;21911.12355505778;22352.55294894093;22380.888095559418;16680.49958501235;16708.24812883423;16888;16918.154092295335;17065.317387304494;3627.9455808162897;3650.8539658413633;3651.99570118217;3652.2330310634798;3673;129214.35392822976;130277.34861325727;130388.34805826005;130449;135486;17021.31914723397;17496.387626433014;17732.20205090774;17970.92174469536;17977.19102640384;31777.20556986094;32462;32627.83686081602;32751.344973100404;32804;7468.253174682488;7879.369650427952;8640.870386944202;8840.602172902234;9135.177833994972;4083.469149010669;4160.687948403821;4178.247915375262;4178.519470260898;4182.059036716714;5234.450382709761;5245.449227831099;5279.868003299948;5296.761645725875;5393.7572809223675;908.0374802709149;931.9301052421096;936.784539555906;945.0171821305902;945.5697657565792;668.8327918020495;693.4175292754111;699.9160100787938;706.7173130747742;715.1204019056589;11702.239354442105;12162.452689628988;12522.48830608097;12611.432485538173;12902.67743306406;689.4518857508293;699.9720011199597;701.8596280743872;712.6436781609195;720.6504845150098;5518.2826232590305;5869.559783016291;6246.812595622138;6433.678316084177;6548.27968923418;102638.48680756698;106125;106235;106402;106420.46789766157;90667;93704.53147734217;94976.52511737397;96447.51776241214;97636;81115.59442202751;81166.59416702879;82058.58970705108;84923;85687;11930.434956484398;11950.46222919988;12090.818637720617;12204.2067265631;12587;36488.635113648525;36632.45051324285;36700.26599468049;36845.44731828971;38494.230115398095;46200.30699539577;46380.76809616065;48475.51524484851;61442;71300.64349678218;17942.820571794637;18436.07819609041;18557.257709692;18559.72160417622;18955.526111847314;20410.693839592714;21096.683549747075;21168.894155529124;21223.257185998416;21284.148634054465;17143;17194.484165475056;17263.913680431517;17270.050147242022;17362.65274694524;18347.449576512725;18375;18451.16969736338;18611.720824187378;18647.347342843477;18479.168437420078;18518.629627407645;18645.440636780917;18734;18823.529411764815;12677.429515671633;12886.162399444007;13090.280034597808;13142.34288285601;13202.867971320164;13950.080009571173;14388.35252413623;14408.927955360155;15117.54647360581;15641.765373519635 03:56:39 INFO - PID 8147 | __end_tp_report 03:56:39 INFO - PID 8147 | __start_cc_report 03:56:39 INFO - PID 8147 | _x_x_mozilla_cycle_collect,363 03:56:39 INFO - PID 8147 | __end_cc_report 03:56:39 INFO - PID 8147 | __startTimestamp1501930599894__endTimestamp 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | ------- Summary: start ------- 03:56:39 INFO - PID 8147 | Number of tests: 6 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | [#0] dojo.html Cycles:165 Average:6186.07 Median:6387.65 stddev:727.52 (11.4%) stddev-sans-first:689.52 03:56:39 INFO - PID 8147 | Values: 3144.5 3171.3 3173.5 3189.2 3212.3 6187.3 6263.8 6273.7 6307.8 6359.8 6115.2 6211.1 6231.7 6232.8 6260.9 5689.5 5694.9 5726.2 5727.5 5767.6 5691.7 5726.1 5740.2 5741.3 5749.3 5715.6 5771.1 5783.8 5802.9 5822.7 5696.5 5726.1 5774.9 5797.9 5858.8 5283.7 5551.8 5641.0 5711.6 5715.4 6150.8 6152.3 6191.5 6261.2 6265.7 6574.2 6647.6 6670.3 6693.9 6699.3 6573.3 6672.7 6686.3 6699.6 6804.1 6119.4 6132.4 6139.9 6158.8 6200.9 6899.9 6957.8 6959.1 6961.9 6963.5 6533.2 6596.6 6662.7 6663.4 6672.3 6681.8 6710.7 6783.6 6787.1 6814.4 6585.6 6660.4 6693.2 6780.5 6793.8 6672.0 6719.8 6778.8 6788.1 6814.7 5482.0 5534.1 5545.8 5547.8 5557.5 4670.8 4689.6 4706.6 4727.3 4754.1 5766.9 5833.9 5896.3 5904.3 5911.5 6781.7 6788.6 6789.4 6793.1 6796.2 5816.5 5860.0 5873.9 5878.1 5890.2 5848.5 5921.8 6006.7 6013.5 6016.6 6387.6 6494.3 6499.9 6579.5 6605.5 6723.7 6754.6 6755.3 6755.5 6765.2 6443.5 6502.3 6538.2 6544.5 6545.6 6553.0 6631.0 6638.3 6642.5 6644.6 6841.9 6852.5 6858.2 6870.0 6885.3 6521.5 6547.6 6615.3 6616.2 6619.2 6524.1 6529.3 6602.0 6629.7 6630.5 6276.0 6311.4 6367.0 6373.6 6378.4 6466.7 6467.2 6555.4 6563.0 6582.5 6157.6 6382.1 6400.0 6498.6 6499.1 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | [#1] ext.html Cycles:180 Average:36859.25 Median:3511.52 stddev:51972.62 (1480.1%) stddev-sans-first:52047.77 03:56:39 INFO - PID 8147 | Values: 771.7 805.0 856.7 1145.4 1179.4 29450.0 40026.6 40887.0 40970.2 40991.0 40683.6 40695.2 40830.4 41070.0 41100.4 7203.9 7541.9 7820.4 7827.8 7843.8 7623.9 7725.2 7727.4 7728.1 7732.0 7729.0 7739.0 7778.4 7784.8 7785.3 7709.2 7711.7 7743.7 7748.2 7750.3 7565.3 7575.0 7624.8 7642.8 7643.0 37862.4 37864.2 37944.6 38024.2 38050.2 3488.0 3535.0 3539.3 3583.5 3594.7 30285.0 30544.0 30554.0 30563.7 30598.7 4696.5 4950.5 4981.2 4996.2 5035.6 190474.0 190828.0 191500.0 191718.0 192607.0 47971.8 48132.5 48266.8 48319.8 48402.0 50568.5 50745.0 51009.7 51058.7 51109.5 13285.0 15351.6 15600.1 15643.0 15659.7 11057.8 11138.8 11316.4 11323.6 11328.7 13388.5 13399.0 13466.3 13531.3 13661.2 5403.8 5486.2 5562.2 5568.3 5700.9 970.5 988.0 999.0 1009.3 1010.0 22342.2 22458.6 22568.9 22657.4 22701.5 1085.5 1098.8 1114.4 1114.9 1119.6 11837.6 11877.2 12013.2 12046.5 12114.9 221812.0 223446.0 223450.0 223582.0 224531.6 51308.2 51359.2 51636.0 51673.2 51695.7 1398.3 1440.3 1443.9 1448.2 1473.2 22191.7 22449.0 22459.2 22597.2 22791.7 36048.3 36169.0 36174.6 36189.6 36247.8 184563.1 184696.0 184764.0 185307.0 185466.0 32233.8 32752.0 33993.5 34721.5 34747.5 44610.1 45326.5 45608.8 45779.5 45991.8 33404.0 33596.8 33967.5 34031.6 34266.1 32129.8 32762.7 32897.5 33523.8 33939.7 35564.1 35910.8 36338.8 36576.3 36582.6 31809.2 31949.4 32056.8 32191.2 32923.8 23864.0 23956.3 24459.4 24577.5 24637.6 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | [#2] jquery.html Cycles:180 Average:35321.79 Median:23111.65 stddev:85914.24 (371.7%) stddev-sans-first:86115.63 03:56:39 INFO - PID 8147 | Values: 571.9 588.5 590.5 596.3 597.8 20173.4 21107.3 21110.4 21136.6 22492.6 27138.7 27779.7 27795.3 27809.0 27914.4 6406.2 6482.1 6535.9 6589.4 6589.9 5911.8 6503.1 6504.9 6518.8 6525.4 6480.0 6486.9 6489.0 6490.8 6503.5 6476.7 6498.8 6499.2 6507.2 6507.7 5969.3 6066.4 6074.1 6075.2 6085.7 29179.3 29607.7 30248.2 30431.0 30443.5 1800.1 1851.0 1851.4 1851.4 1860.3 18776.2 19335.2 19469.2 19532.3 19543.8 2412.8 2431.8 2440.7 2508.7 2512.5 129241.0 131263.0 131284.7 131308.0 132458.0 14380.4 14743.3 15256.3 15472.8 15695.7 24183.6 24208.4 24235.3 24250.2 24282.6 9837.2 10010.6 10029.1 10070.1 10191.9 7307.4 9137.6 9166.6 9325.3 9334.9 8071.4 9231.2 9477.7 9506.1 9583.4 2753.1 2762.9 2777.6 2784.4 2862.0 932.7 964.5 975.3 994.5 996.9 19573.5 19742.8 19789.3 20218.8 20445.6 1018.8 1024.3 1031.1 1035.2 1038.0 10983.2 11165.5 11169.6 11176.4 11200.9 468503.0 511434.0 513898.0 529740.0 537664.0 112962.4 114165.0 118212.4 118388.6 119322.4 1164.9 1193.9 1203.9 1204.2 1208.0 17757.8 17957.4 18002.7 18166.2 18173.0 56276.4 57399.7 57789.1 58297.0 58333.4 70806.6 71137.6 71726.6 71779.3 73368.3 12199.1 12799.4 13259.3 14412.1 14745.3 23029.2 23084.3 23139.0 23397.3 23406.2 18365.5 18645.4 18656.2 18703.6 19067.1 16405.0 16857.2 16921.7 17391.4 17518.2 18184.0 18950.6 19175.7 19196.0 19197.4 14656.1 14680.9 14736.7 14749.0 14765.2 18444.1 18611.2 18614.8 18625.6 18868.4 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | [#3] mootools.html Cycles:180 Average:8693.39 Median:2391.52 stddev:6059.38 (253.4%) stddev-sans-first:6051.14 03:56:39 INFO - PID 8147 | Values: 1331.9 1370.5 1389.1 1393.9 1404.0 13572.7 14113.9 14207.8 14221.1 14229.8 13574.2 14015.9 14022.9 14026.4 14083.6 2507.2 2533.6 2536.8 2543.5 2552.4 2442.1 2445.2 2491.9 2563.9 2668.4 2491.3 2533.3 2534.6 2535.8 2539.9 2278.2 2283.7 2292.9 2297.6 2300.1 2378.1 2405.0 2421.6 2429.2 2429.8 13759.6 13800.6 13950.2 14008.4 14066.4 7293.1 7529.7 7530.5 7546.3 7571.4 4967.3 4993.9 5111.5 5168.3 5179.9 1816.4 1828.4 1829.1 1875.8 1879.3 23078.9 23282.5 23291.1 23334.6 23341.1 5933.3 6027.3 6234.3 6273.2 6273.9 15693.5 15693.8 15697.2 15723.4 15730.3 7118.7 7261.6 7360.3 7364.6 7367.6 6353.3 6642.8 6812.9 6866.9 6919.2 4676.2 4884.6 4903.3 4904.3 4904.7 1297.4 1318.1 1382.5 1393.3 1448.4 892.4 897.7 901.9 910.9 923.4 8257.1 8295.0 8298.1 8401.8 8470.7 974.2 986.4 987.1 987.9 992.5 4851.8 4932.0 4982.4 5061.5 5128.5 19282.8 19952.1 19957.9 20083.4 20167.7 19150.1 19535.9 19913.0 19944.0 19985.5 10759.1 11071.4 11099.9 11114.0 11117.3 7458.7 7917.0 7930.4 7955.3 8055.6 16721.4 16971.5 17383.4 17462.3 17531.5 17675.8 17725.7 17884.2 18002.8 18023.3 10034.9 10090.8 10183.7 10190.6 10250.7 13008.5 13133.1 13188.0 13196.9 13213.3 10879.4 10945.7 11191.6 11213.8 11326.8 10259.3 10308.9 10326.4 10378.3 10598.2 9075.4 9318.7 9373.3 9532.0 9682.6 7230.0 7242.9 7304.6 7347.3 7365.5 7264.9 7284.3 7322.1 7322.3 7370.6 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | [#4] prototype.html Cycles:180 Average:5434.09 Median:6077.70 stddev:1544.72 (25.4%) stddev-sans-first:1503.26 03:56:39 INFO - PID 8147 | Values: 460.2 476.2 495.4 499.2 501.7 6154.7 6209.9 6234.4 6243.6 6261.6 5931.3 6067.2 6067.8 6071.9 6083.5 4832.6 4846.5 4861.5 4886.5 4896.3 4821.7 4823.6 4854.4 4863.0 4883.1 4857.8 4864.9 4874.2 4879.8 4889.6 4842.4 4856.8 4864.9 4888.3 4901.2 4344.5 4353.6 4378.5 4409.9 4424.8 5938.9 5967.3 6089.3 6095.2 6100.4 5522.1 5589.2 5589.5 5613.6 5627.5 6330.4 6371.6 6388.9 6428.8 6458.5 4769.5 4774.2 4795.1 4830.6 4847.4 6751.3 6799.8 6839.7 6843.9 6872.6 4763.7 4854.4 4865.7 4878.9 4908.9 4923.0 4946.9 4962.3 4972.2 5007.3 5528.8 5561.3 5612.5 5618.6 5659.3 6465.0 6494.6 6522.0 6543.2 6562.5 1632.3 1640.3 1688.8 1702.4 1728.8 1153.8 1155.6 1176.9 1182.7 1186.3 5615.9 5647.3 5683.2 5702.7 5710.5 6376.8 6487.6 6694.6 6726.0 6762.5 5693.2 5704.7 5749.2 5777.2 5814.6 3476.5 3491.2 3528.3 3537.7 3565.3 6388.5 6419.1 6478.6 6481.5 6484.6 6771.7 6789.8 6812.0 6866.9 6916.1 6372.7 6410.7 6446.8 6492.5 6506.8 6558.7 6591.1 6604.2 6639.6 6726.8 6579.7 6581.3 6582.8 6666.3 6703.6 6362.9 6444.9 6461.9 6469.6 6496.9 4848.3 4855.9 4882.5 4888.7 4894.9 6434.6 6613.0 6724.8 6739.5 6762.5 6336.5 6408.6 6482.8 6528.2 6543.0 6451.9 6452.5 6505.8 6512.5 6553.2 6312.9 6341.8 6352.1 6391.2 6425.9 6316.9 6448.3 6498.5 6561.0 6585.8 6236.3 6270.2 6337.4 6341.2 6349.7 03:56:39 INFO - PID 8147 | 03:56:39 INFO - PID 8147 | [#5] yui.html Cycles:180 Average:23308.54 Median:21030.63 stddev:31345.04 (149.0%) stddev-sans-first:31387.57 03:56:39 INFO - PID 8147 | Values: 842.1 873.6 879.8 900.5 921.7 18464.7 19752.0 19768.3 19782.1 20964.6 21364.5 21793.9 21837.9 22087.2 22229.6 1002.9 1052.4 1053.7 1054.1 1054.6 1019.4 1059.3 1067.3 1069.4 1070.9 1107.3 1120.7 1122.5 1123.4 1123.6 1115.0 1118.2 1119.4 1119.6 1121.4 817.8 820.4 821.5 822.6 822.8 19848.9 19942.4 20359.2 20390.8 20730.9 21285.9 21793.6 21911.1 22352.6 22380.9 16680.5 16708.2 16888.0 16918.2 17065.3 3627.9 3650.9 3652.0 3652.2 3673.0 129214.4 130277.3 130388.3 130449.0 135486.0 17021.3 17496.4 17732.2 17970.9 17977.2 31777.2 32462.0 32627.8 32751.3 32804.0 7468.3 7879.4 8640.9 8840.6 9135.2 4083.5 4160.7 4178.2 4178.5 4182.1 5234.5 5245.4 5279.9 5296.8 5393.8 908.0 931.9 936.8 945.0 945.6 668.8 693.4 699.9 706.7 715.1 11702.2 12162.5 12522.5 12611.4 12902.7 689.5 700.0 701.9 712.6 720.7 5518.3 5869.6 6246.8 6433.7 6548.3 102638.5 106125.0 106235.0 106402.0 106420.5 90667.0 93704.5 94976.5 96447.5 97636.0 81115.6 81166.6 82058.6 84923.0 85687.0 11930.4 11950.5 12090.8 12204.2 12587.0 36488.6 36632.5 36700.3 36845.4 38494.2 46200.3 46380.8 48475.5 61442.0 71300.6 17942.8 18436.1 18557.3 18559.7 18955.5 20410.7 21096.7 21168.9 21223.3 21284.1 17143.0 17194.5 17263.9 17270.1 17362.7 18347.4 18375.0 18451.2 18611.7 18647.3 18479.2 18518.6 18645.4 18734.0 18823.5 12677.4 12886.2 13090.3 13142.3 13202.9 13950.1 14388.4 14408.9 15117.5 15641.8 03:56:39 INFO - PID 8147 | -------- Summary: end -------- 03:56:39 INFO - PID 8147 | 03:56:40 INFO - TEST-INFO | 8147: exit 0 03:56:40 INFO - TEST-OK | dromaeo_css | took 1112629ms 03:56:40 INFO - TEST-START | kraken 03:56:40 INFO - Initialising browser for kraken test... 03:56:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36395/getInfo.html -profile /tmp/tmpz8vAJj/profile 03:56:40 INFO - TEST-INFO | started process 8509 (/builds/slave/test/build/application/firefox/firefox http://localhost:36395/getInfo.html) 03:56:46 INFO - TEST-INFO | 8509: exit 0 03:56:46 INFO - Browser initialized. 03:56:46 INFO - Running cycle 1/1 for kraken test... 03:56:46 INFO - TEST-INFO | started process 8715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8vAJj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:47 INFO - PID 8715 | 03:56:47 INFO - PID 8715 | (/builds/slave/test/build/application/firefox/firefox:8763): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:56:47 INFO - PID 8715 | 03:56:57 INFO - PID 8715 | RSS: Main: 170934272 03:56:57 INFO - PID 8715 | 03:57:00 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:01 INFO - PID 8715 | RSS: Main: 176066560 03:57:01 INFO - PID 8715 | 03:57:04 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-dft) 03:57:04 INFO - PID 8715 | RSS: Main: 176807936 03:57:04 INFO - PID 8715 | 03:57:07 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-fft) 03:57:08 INFO - PID 8715 | RSS: Main: 171315200 03:57:08 INFO - PID 8715 | 03:57:10 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36395/tests/kraken/driver.html?testName=audio-oscillator) 03:57:11 INFO - PID 8715 | RSS: Main: 172167168 03:57:11 INFO - PID 8715 | 03:57:13 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:13 INFO - PID 8715 | RSS: Main: 172478464 03:57:13 INFO - PID 8715 | 03:57:16 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36395/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:17 INFO - PID 8715 | RSS: Main: 174931968 03:57:17 INFO - PID 8715 | 03:57:21 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36395/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:21 INFO - PID 8715 | RSS: Main: 174956544 03:57:21 INFO - PID 8715 | 03:57:24 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36395/tests/kraken/driver.html?testName=json-parse-financial) 03:57:25 INFO - PID 8715 | RSS: Main: 175181824 03:57:25 INFO - PID 8715 | 03:57:26 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:27 INFO - PID 8715 | RSS: Main: 174985216 03:57:27 INFO - PID 8715 | 03:57:29 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:29 INFO - PID 8715 | RSS: Main: 175190016 03:57:29 INFO - PID 8715 | 03:57:32 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:32 INFO - PID 8715 | RSS: Main: 172072960 03:57:32 INFO - PID 8715 | 03:57:35 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:36 INFO - PID 8715 | RSS: Main: 172859392 03:57:36 INFO - PID 8715 | 03:57:39 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:39 INFO - PID 8715 | RSS: Main: 172589056 03:57:39 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | Cycle 1(1): loaded http://localhost:36395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36395/tests/kraken/driver.html?testName=ai-astar) 03:57:41 INFO - PID 8715 | RSS: Main: 174428160 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | __start_tp_report 03:57:41 INFO - PID 8715 | _x_x_mozilla_page_load 03:57:41 INFO - PID 8715 | _x_x_mozilla_page_load_details 03:57:41 INFO - PID 8715 | |i|pagename|runs| 03:57:41 INFO - PID 8715 | |0;ai-astar;98;110;101;107;110;109;110;98;109;110 03:57:41 INFO - PID 8715 | |1;audio-beat-detection;150;126;146;180;126;149;146;118;175;118 03:57:41 INFO - PID 8715 | |2;audio-dft;165;163;163;164;163;165;171;166;168;163 03:57:41 INFO - PID 8715 | |3;audio-fft;74;75;77;175;76;75;76;75;153;79 03:57:41 INFO - PID 8715 | |4;audio-oscillator;80;79;130;91;79;80;131;79;79;137 03:57:41 INFO - PID 8715 | |5;imaging-gaussian-blur;115;114;115;115;114;115;114;114;114;114 03:57:41 INFO - PID 8715 | |6;imaging-darkroom;150;152;150;151;151;152;151;151;152;151 03:57:41 INFO - PID 8715 | |7;imaging-desaturate;94;94;95;94;94;95;94;95;96;94 03:57:41 INFO - PID 8715 | |8;json-parse-financial;55;57;56;57;56;56;55;55;58;55 03:57:41 INFO - PID 8715 | |9;json-stringify-tinderbox;54;55;55;55;54;54;55;54;54;54 03:57:41 INFO - PID 8715 | |10;stanford-crypto-aes;80;89;78;88;89;89;78;77;98;79 03:57:41 INFO - PID 8715 | |11;stanford-crypto-ccm;136;128;131;137;135;127;131;127;126;163 03:57:41 INFO - PID 8715 | |12;stanford-crypto-pbkdf2;183;194;179;179;180;177;199;179;171;169 03:57:41 INFO - PID 8715 | |13;stanford-crypto-sha256-iterative;76;66;65;66;66;66;66;69;64;66 03:57:41 INFO - PID 8715 | __end_tp_report 03:57:41 INFO - PID 8715 | __start_cc_report 03:57:41 INFO - PID 8715 | _x_x_mozilla_cycle_collect,981 03:57:41 INFO - PID 8715 | __end_cc_report 03:57:41 INFO - PID 8715 | __startTimestamp1501930661902__endTimestamp 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | ------- Summary: start ------- 03:57:41 INFO - PID 8715 | Number of tests: 14 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#0] ai-astar Cycles:10 Average:106.20 Median:110.00 stddev:5.12 (4.7%) stddev-sans-first:4.48 03:57:41 INFO - PID 8715 | Values: 98.0 110.0 101.0 107.0 110.0 109.0 110.0 98.0 109.0 110.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:147.50 stddev:21.91 (14.9%) stddev-sans-first:23.11 03:57:41 INFO - PID 8715 | Values: 150.0 126.0 146.0 180.0 126.0 149.0 146.0 118.0 175.0 118.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.64 (1.6%) stddev-sans-first:2.80 03:57:41 INFO - PID 8715 | Values: 165.0 163.0 163.0 164.0 163.0 165.0 171.0 166.0 168.0 163.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:37.54 (49.7%) stddev-sans-first:39.15 03:57:41 INFO - PID 8715 | Values: 74.0 75.0 77.0 175.0 76.0 75.0 76.0 75.0 153.0 79.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.00 stddev:25.28 (32.0%) stddev-sans-first:26.10 03:57:41 INFO - PID 8715 | Values: 80.0 79.0 130.0 91.0 79.0 80.0 131.0 79.0 79.0 137.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:57:41 INFO - PID 8715 | Values: 115.0 114.0 115.0 115.0 114.0 115.0 114.0 114.0 114.0 114.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 03:57:41 INFO - PID 8715 | Values: 150.0 152.0 150.0 151.0 151.0 152.0 151.0 151.0 152.0 151.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 03:57:41 INFO - PID 8715 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 96.0 94.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.05 (1.9%) stddev-sans-first:1.05 03:57:41 INFO - PID 8715 | Values: 55.0 57.0 56.0 57.0 56.0 56.0 55.0 55.0 58.0 55.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 03:57:41 INFO - PID 8715 | Values: 54.0 55.0 55.0 55.0 54.0 54.0 55.0 54.0 54.0 54.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:88.50 stddev:7.04 (8.0%) stddev-sans-first:7.28 03:57:41 INFO - PID 8715 | Values: 80.0 89.0 78.0 88.0 89.0 89.0 78.0 77.0 98.0 79.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:133.00 stddev:10.91 (8.2%) stddev-sans-first:11.55 03:57:41 INFO - PID 8715 | Values: 136.0 128.0 131.0 137.0 135.0 127.0 131.0 127.0 126.0 163.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:179.50 stddev:9.25 (5.2%) stddev-sans-first:9.78 03:57:41 INFO - PID 8715 | Values: 183.0 194.0 179.0 179.0 180.0 177.0 199.0 179.0 171.0 169.0 03:57:41 INFO - PID 8715 | 03:57:41 INFO - PID 8715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.00 stddev:3.40 (5.2%) stddev-sans-first:1.32 03:57:41 INFO - PID 8715 | Values: 76.0 66.0 65.0 66.0 66.0 66.0 66.0 69.0 64.0 66.0 03:57:41 INFO - PID 8715 | -------- Summary: end -------- 03:57:41 INFO - PID 8715 | 03:57:42 INFO - PID 8715 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:57:42 INFO - TEST-INFO | 8715: exit 0 03:57:42 INFO - TEST-OK | kraken | took 61964ms 03:57:42 INFO - SUITE-END | took 1174s 03:57:43 INFO - Completed test suite (00:19:35) 03:57:43 INFO - javascript benchmark 03:57:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8424.389597777796, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.4811606084995, 3171.3498732759786, 3173.508106243533, 3189.1867573768686, 3212.3414699986492, 6187.257529096503, 6263.780767673133, 6273.686315684215, 6307.842303942403, 6359.8092057238355, 6115.235595550556, 6211.130441738149, 6231.719572619231, 6232.844178895519, 6260.906086408696, 5689.544836413098, 5694.886102277962, 5726.198332233491, 5727.541796656278, 5767.625104368223, 5691.715414229293, 5726.055200891848, 5740.225069615611, 5741.33974592923, 5749.252597162363, 5715.599908006441, 5771.105478650816, 5783.797567085153, 5802.854928626776, 5822.737976791054, 5696.487316141567, 5726.112452569859, 5774.88450230993, 5797.855053623651, 5858.76564937402, 5283.709395983219, 5551.750171242264, 5641.0, 5711.571632127566, 5715.399883012307, 6150.7847225346895, 6152.292486364081, 6191.504679625619, 6261.154744109578, 6265.655388953605, 6574.211094668671, 6647.6011439313315, 6670.3329667033395, 6693.866122677568, 6699.263081061079, 6573.30980247072, 6672.733090676367, 6686.264510903797, 6699.631520266384, 6804.08144900437, 6119.44924956756, 6132.41742034506, 6139.938600614026, 6158.846028849225, 6200.906986395207, 6899.93100069003, 6957.82605434858, 6959.060526828915, 6961.860762784716, 6963.547369420971, 6533.150690410312, 6596.604203747695, 6662.700178491883, 6663.36698013688, 6672.266050734415, 6681.766138185238, 6710.664466776641, 6783.559068660521, 6787.083743694538, 6814.352636499525, 6585.637789921505, 6660.367265109807, 6693.230278517935, 6780.525363224626, 6793.762218322335, 6672.0, 6719.798406047827, 6778.830529236809, 6788.1175447191545, 6814.727410903508, 5482.013237617267, 5534.142207957773, 5545.805896793593, 5547.77808887648, 5557.472040156179, 4670.7664616769025, 4689.577937985598, 4706.552877476634, 4727.2909063640045, 4754.120487709784, 5766.913496297559, 5833.854153646108, 5896.292444906639, 5904.261967254093, 5911.527077833763, 6781.6609169541325, 6788.558743681645, 6789.422899053537, 6793.082933803873, 6796.184457865088, 5816.505597024216, 5860.033094539439, 5873.911891321633, 5878.059510478303, 5890.175375447441, 5848.466998792027, 5921.822345329647, 6006.729697163551, 6013.51891848651, 6016.639001659914, 6387.648679322682, 6494.318096599789, 6499.902501462388, 6579.506537009744, 6605.504587155887, 6723.663816809238, 6754.628495432798, 6755.256921738506, 6755.459563235027, 6765.154355705537, 6443.484521238383, 6502.252240992347, 6538.1827271591055, 6544.509161812788, 6545.639989800607, 6552.967235163794, 6631.0, 6638.302978187221, 6642.501812363996, 6644.634545100066, 6841.897371539331, 6852.45180385558, 6858.2455929848675, 6870.0, 6885.2770459101075, 6521.543491955707, 6547.639879806657, 6615.338466153346, 6616.239132499824, 6619.172603424572, 6524.119243902012, 6529.281779004211, 6602.042703807825, 6629.734810607714, 6630.46956243509, 6276.0, 6311.431971122621, 6367.044943258548, 6373.6175829450385, 6378.394052564999, 6466.741330346734, 6467.191601049869, 6555.4427873631275, 6563.048357987969, 6582.506312026713, 6157.630542167484, 6382.106505089198, 6400.0, 6498.610083395011, 6499.122618446449], "value": 6131.797516545342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.7183228121737, 804.9637766300516, 856.7215654912153, 1145.4101137913976, 1179.4456605395471, 29450.0, 40026.59973400265, 40886.99999999996, 40970.180596388054, 40991.0, 40683.59316406835, 40695.186096278056, 40830.387544186786, 41070.0, 41100.38349424761, 7203.89194162088, 7541.924580754205, 7820.374370050411, 7827.804304892366, 7843.843123137533, 7623.885641715378, 7725.18885517021, 7727.38180945523, 7728.072631284225, 7732.0, 7728.961355193244, 7738.961305193466, 7778.4166187535875, 7784.805379865492, 7785.299323060924, 7709.151993280735, 7711.691532338699, 7743.651535680908, 7748.1864404237585, 7750.302472777449, 7565.319121279056, 7575.0, 7624.847503049908, 7642.8089297768, 7643.0, 37862.43206351879, 37864.24271514554, 37944.62055379466, 38024.23951520982, 38050.238995220214, 3488.0407887830797, 3535.0, 3539.327527769741, 3583.516225309576, 3594.730395220343, 30285.0, 30544.0, 30554.0, 30563.694363056307, 30598.69401306003, 4696.530346965276, 4950.529699678561, 4981.178105612569, 4996.1756310208775, 5035.62232832539, 190474.0, 190828.0, 191500.0, 191718.0, 192607.0, 47971.76014119907, 48132.5186748128, 48266.75866620644, 48319.75840120847, 48402.0, 50568.49431505711, 50745.0, 51009.744951275745, 51058.74470627697, 51109.48890511122, 13285.0, 15351.616209594626, 15600.14199219031, 15643.0, 15659.686806263811, 11057.834132488018, 11138.832917506244, 11316.37759923212, 11323.603673871376, 11328.660140195807, 13388.464461421434, 13399.0, 13466.259355735332, 13531.255780931946, 13661.248631325372, 5403.8108666196495, 5486.1770734389365, 5562.221289019541, 5568.303962004749, 5700.8859822803315, 970.4953424219366, 987.9851802222972, 998.960041598328, 1009.3035805294323, 1009.9697009089739, 22342.21802236914, 22458.550828983654, 22568.887155564116, 22657.433564161027, 22701.545969080857, 1085.5386460754148, 1098.8406681031206, 1114.3870871020906, 1114.9163812713916, 1119.5857532712785, 11837.644870653894, 11877.168598198215, 12013.219140755822, 12046.51813927433, 12114.939425302993, 221812.0, 223446.0, 223450.0, 223582.0, 224531.63202551974, 51308.23037654438, 51359.22961155586, 51636.0, 51673.224901626505, 51695.741521292155, 1398.3288021749618, 1440.287057906343, 1443.9100325303648, 1448.174540511919, 1473.2191938272733, 22191.667124992815, 22449.0, 22459.213927512457, 22597.2090976815, 22791.65812512847, 36048.27903441969, 36169.0, 36174.63825361818, 36189.63810361968, 36247.818760906026, 184563.0771846132, 184696.0, 184764.0, 185307.0, 185466.0, 32233.838830805696, 32752.0, 33993.490097649046, 34721.47917781286, 34747.478787817694, 44610.10779784451, 45326.54673453223, 45608.77195614001, 45779.54220457886, 45991.77004114958, 33404.0, 33596.83201583976, 33967.49048764221, 34031.638734450346, 34266.14334641654, 32129.839350803097, 32762.672373275964, 32897.50653740148, 33523.83238083794, 33939.66060339365, 35564.11089722778, 35910.8204458976, 36338.81830590936, 36576.26847463089, 36582.63417365792, 31809.204769880937, 31949.36101277915, 32056.83971580127, 32191.195220119684, 32923.835380822944, 23864.0, 23956.281311559986, 24459.38851528726, 24577.50844983126, 24637.630435543124], "value": 16944.887583911965, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.8741876787108, 588.4733163818386, 590.5452801342966, 596.296370283066, 597.7818096394816, 20173.39479815604, 21107.2612458564, 21110.366688999355, 21136.57726845462, 22492.550148997012, 27138.72861271387, 27779.722202778015, 27795.305117372074, 27809.0, 27914.441711165815, 6406.199225096863, 6482.092507049017, 6535.934640653604, 6589.439897608709, 6589.868202635945, 5911.793087241947, 6503.089567460559, 6504.869902601945, 6518.771842985473, 6525.3800888915475, 6479.967600161993, 6486.870262594745, 6489.0266460031135, 6490.772822951198, 6503.544751867371, 6476.708548115346, 6498.772542960974, 6499.1876015498065, 6507.186601674791, 6507.739690412425, 5969.343372229051, 6066.393360663942, 6074.119252708377, 6075.179850720185, 6085.726142323606, 29179.270518237, 29607.70392296071, 30248.243793905327, 30431.0, 30443.543346849816, 1800.126938434858, 1851.018959951228, 1851.3797877710983, 1851.3797877710983, 1860.283790740561, 18776.15507302161, 19335.226590936345, 19469.221231150736, 19532.31636892702, 19543.80456195434, 2412.7587241275905, 2431.805455563551, 2440.6583078369044, 2508.7240403555593, 2512.522620702061, 129241.0, 131263.0, 131284.6871531282, 131308.0, 132458.0, 14380.424783008562, 14743.262836858114, 15256.313465894062, 15472.839537034542, 15695.68608627821, 24183.637245441332, 24208.394790130387, 24235.272941811774, 24250.15124470635, 24282.635760463607, 9837.213022958289, 10010.649627263156, 10029.147522460527, 10070.144037756872, 10191.94904025475, 7307.415406767446, 9137.63449462014, 9166.587503562356, 9325.347225694271, 9334.906650933404, 8071.354291656653, 9231.169194772503, 9477.715668529818, 9506.144446999664, 9583.377080489747, 2753.0914798116573, 2762.8894844206407, 2777.569626576745, 2784.4013537089622, 2861.957070643942, 932.7481579973369, 964.4599024546277, 975.2929126383316, 994.5325696922434, 996.8853581838182, 19573.510662233275, 19742.802571974386, 19789.30737424183, 20218.797812021985, 20445.591088178153, 1018.7707765752647, 1024.349538043333, 1031.1029404418205, 1035.2442716816615, 1037.9636712715019, 10983.231173817756, 11165.497552610152, 11169.553217871195, 11176.441177941071, 11200.943995279971, 468503.0, 511434.0, 513898.0, 529740.0, 537664.0, 112962.43518782518, 114165.0, 118212.40893795477, 118388.63222735497, 119322.4033879825, 1164.930104193751, 1193.8985186259265, 1203.915725899196, 1204.2292932523017, 1208.0335731414832, 17757.822421776134, 17957.371491997717, 18002.729959050364, 18166.182521786286, 18173.0, 56276.43723562876, 57399.71300143473, 57789.133163001745, 58297.0, 58333.416665832796, 70806.6459667719, 71137.64431177812, 71726.64136679283, 71779.28220717725, 73368.26631733614, 12199.14605977573, 12799.42402591867, 13259.337033148111, 14412.13527188372, 14745.336459859118, 23029.193978210682, 23084.307470775904, 23139.0, 23397.298081057597, 23406.18078367249, 18365.54086147857, 18645.440636780917, 18656.16047277903, 18703.625927481648, 19067.141978611275, 16405.0, 16857.15714214309, 16921.661566768842, 17391.391301304393, 17518.211680474153, 18184.0, 18950.620987580445, 19175.712364314826, 19196.040197989765, 19197.424077277705, 14656.120632762068, 14680.853191468375, 14736.705265894409, 14749.0, 14765.187914664366, 18444.07779611041, 18611.162497687365, 18614.81385186131, 18625.627487450445, 18868.43394698161], "value": 11970.353447170803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.893448524118, 1370.5340184337324, 1389.0554422992368, 1393.8884889208864, 1403.9859601403982, 13572.728545429085, 14113.858861411383, 14207.78688319676, 14221.07563008405, 14229.78655320171, 13574.18554886705, 14015.859841401583, 14022.859771402309, 14026.43894244229, 14083.647908802284, 2507.1601013660447, 2533.6326232696247, 2536.7843733282693, 2543.504016716741, 2552.3619095226195, 2442.0598069743187, 2445.1686426614947, 2491.8878650460774, 2563.9487210255784, 2668.3996100877243, 2491.302435318114, 2533.2526904563197, 2534.6451496790464, 2535.8098142639283, 2539.9492010159784, 2278.2481781012225, 2283.6574513822893, 2292.873891935943, 2297.6208925527267, 2300.114455934477, 2378.084437491561, 2404.9639255411007, 2421.6488609151575, 2429.2105065853666, 2429.7691719286818, 13759.587212383645, 13800.585982420544, 13950.162990220519, 14008.369623366973, 14066.367013484418, 7293.124825021031, 7529.661165247522, 7530.510516816389, 7546.2831031051965, 7571.432142589328, 4967.304577359173, 4993.85141417476, 5111.514406131411, 5168.302279192299, 5179.922301165486, 1816.4459839748872, 1828.414907229687, 1829.0945981739123, 1875.756151700284, 1879.2858713688847, 23078.884605577034, 23282.53434931309, 23291.06835726569, 23334.64998025031, 23341.066357345684, 5933.3473317934995, 6027.306859711101, 6234.2830574483605, 6273.215848018997, 6273.8745225095245, 15693.529194124194, 15693.764593531107, 15697.21513924322, 15723.371065157266, 15730.292136853868, 7118.71525138999, 7261.564306141649, 7360.33756961876, 7364.631768411665, 7367.5579465231185, 6353.269374022047, 6642.800715978528, 6812.93187068123, 6866.896996545056, 6919.238883722786, 4676.18166820805, 4884.584810291165, 4903.33804936329, 4904.337914381513, 4904.681195722338, 1297.4031945305264, 1318.1234479071502, 1382.5022991723172, 1393.3451277899371, 1448.4133925760084, 892.4422236102436, 897.6678628907346, 901.89517840646, 910.8588168833709, 923.3582660051334, 8257.091719910804, 8295.0, 8298.128696486781, 8401.789955251168, 8470.66117355299, 974.2060220919927, 986.4081551069445, 987.0721521769657, 987.8567607696843, 992.4690290694443, 4851.757412129379, 4932.0, 4982.402111746614, 5061.544460998454, 5128.487151284916, 19282.8071719281, 19952.10215540275, 19957.900210498854, 20083.397498075083, 20167.697484537744, 19150.138243779063, 19535.902320488305, 19913.0, 19944.0, 19985.500362490762, 10759.139268858473, 11071.391073491035, 11099.944500277608, 11114.0, 11117.27737697047, 7458.664360103699, 7916.972722321252, 7930.405219608437, 7955.323797477279, 8055.556944368116, 16721.414750483676, 16971.490855274362, 17383.391581294592, 17462.30150793954, 17531.474055778348, 17675.823241767932, 17725.73411398804, 17884.195211215265, 18002.819971800116, 18023.2790688371, 10034.949825250827, 10090.8486372703, 10183.694489165337, 10190.567507640666, 10250.743731406774, 13008.544700935421, 13133.146345487512, 13188.010899182407, 13196.868031319564, 13213.273269969859, 10879.401632910265, 10945.726356840823, 11191.608293709682, 11213.831792522955, 11326.830097548378, 10259.307214309556, 10308.948455257676, 10326.432046237529, 10378.273520853469, 10598.20513461478, 9075.410098343587, 9318.72043838686, 9373.297002724687, 9532.0, 9682.56428460735, 7230.0, 7242.89135662955, 7304.598247096461, 7347.302006309392, 7365.484416091036, 7264.854702906018, 7284.307990740871, 7322.0847394075745, 7322.304381083789, 7370.5946172961], "value": 6275.576585433486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.222224440695, 476.2451514349755, 495.36840528326377, 499.20127795527156, 501.6513523101446, 6154.69226538673, 6209.9068513972325, 6234.438900498954, 6243.594166379182, 6261.592996455227, 5931.258592675916, 6067.237218783256, 6067.817965461032, 6071.908921366172, 6083.498211323622, 4832.64685887952, 4846.515348465161, 4861.538153875394, 4886.53577910098, 4896.314515967767, 4821.733785120988, 4823.614110871139, 4854.393200849894, 4863.0, 4883.12103821312, 4857.781399837016, 4864.854054378375, 4874.2444921037295, 4879.804807807701, 4889.559939605435, 4842.443119041285, 4856.781444834991, 4864.854054378375, 4888.266759985995, 4901.166801643729, 4344.478662560481, 4353.564643535653, 4378.496472905625, 4409.883256037088, 4424.84513042042, 5938.853286848134, 5967.313758917737, 6089.330173680892, 6095.207623009025, 6100.420460056288, 5522.144067669517, 5589.189567512688, 5589.528377298186, 5613.578981576398, 5627.54979601635, 6330.366963303679, 6371.55399122057, 6388.936110638881, 6428.753479492873, 6458.515611329169, 4769.546893045155, 4774.188387974053, 4795.112904112751, 4830.637702172316, 4847.418309802846, 6751.324867513258, 6799.796006119825, 6839.7428848479385, 6843.8973415398805, 6872.62200578968, 4763.73799441034, 4854.393200849894, 4865.659403841768, 4878.902421951541, 4908.9263661045115, 4923.01539692063, 4946.9010619787405, 4962.280469331927, 4972.179590367549, 5007.273945277987, 5528.778848846082, 5561.277033985556, 5612.494875461228, 5618.550515958714, 5659.3208814941645, 6465.0, 6494.577852439576, 6522.032475223857, 6543.247526534415, 6562.5406221564035, 1632.2736382309995, 1640.270079814471, 1688.8311168883258, 1702.4296860551854, 1728.7666165067806, 1153.7577108807245, 1155.624422062833, 1176.8999635031118, 1182.6924999500193, 1186.3415804228737, 5615.932972735167, 5647.29408823897, 5683.232763576947, 5702.6863522506665, 5710.514606258432, 6376.776812811529, 6487.610743355413, 6694.55648688235, 6725.982205338379, 6762.526623136333, 5693.17448969897, 5704.714764261853, 5749.223854779551, 5777.220075289866, 5814.563907706939, 3476.495908093312, 3491.2493813830147, 3528.259065596202, 3537.727601968169, 3565.286942611488, 6388.456981156561, 6419.133416988647, 6478.643674597943, 6481.5138864584405, 6484.643344615997, 6771.715717876924, 6789.830254243683, 6811.956413076057, 6866.862662746817, 6916.135483064617, 6372.745090196433, 6410.743570257137, 6446.806595802133, 6492.513061520311, 6506.804795856132, 6558.672066396565, 6591.14315139048, 6604.174478190226, 6639.601623902581, 6726.7981960541265, 6579.671016449254, 6581.308962558863, 6582.80251592453, 6666.333366663489, 6703.597784132772, 6362.918303888443, 6444.9355506444335, 6461.935380646133, 6469.644169570531, 6496.870062598627, 4848.272759086165, 4855.878603034952, 4882.462929077869, 4888.682235654814, 4894.898647804358, 6434.613923164625, 6612.966935165294, 6724.798256052326, 6739.528233023641, 6762.4928130389435, 6336.493080553452, 6408.58344207625, 6482.805515834532, 6528.183977002875, 6543.0, 6451.935480645134, 6452.548321617442, 6505.837354066186, 6512.54412191161, 6553.2136143663065, 6312.873742525032, 6341.8097457076365, 6352.06262090067, 6391.169148010915, 6425.935740642533, 6316.936830631635, 6448.29068802422, 6498.480121590167, 6560.950247960303, 6585.769498067544, 6236.314005459487, 6270.212989298028, 6337.429631333202, 6341.239051313872, 6349.650769207553], "value": 4971.590068937231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.0611018714136, 873.6287077991852, 879.8196369744203, 900.4597241655007, 921.7188757428981, 18464.723029154557, 19752.0, 19768.30810921618, 19782.10980505877, 20964.580708385824, 21364.4658883528, 21793.891030544866, 21837.890810545927, 22087.226947056857, 22229.55540889181, 1002.854586085019, 1052.431686889079, 1053.699695586758, 1054.1356088007838, 1054.6256079091927, 1019.4393083803915, 1059.3061544688242, 1067.3062509368895, 1069.4332004037833, 1070.882202957674, 1107.2581370481796, 1120.7254222715446, 1122.4892673833385, 1123.365298606289, 1123.5898896902654, 1115.041064684371, 1118.2116607791488, 1119.367557330106, 1119.6361182615601, 1121.4000509727298, 817.7587611654576, 820.4093053001889, 821.5440430561036, 822.6051495282298, 822.786075620337, 19848.90075549613, 19942.401727948185, 20359.185632574678, 20390.79609203904, 20730.896345518326, 21285.893570532204, 21793.564128717495, 21911.12355505778, 22352.55294894093, 22380.888095559418, 16680.49958501235, 16708.24812883423, 16888.0, 16918.154092295335, 17065.317387304494, 3627.9455808162897, 3650.8539658413633, 3651.99570118217, 3652.2330310634798, 3673.0, 129214.35392822976, 130277.34861325727, 130388.34805826005, 130449.0, 135486.0, 17021.31914723397, 17496.387626433014, 17732.20205090774, 17970.92174469536, 17977.19102640384, 31777.20556986094, 32462.0, 32627.83686081602, 32751.344973100404, 32804.0, 7468.253174682488, 7879.369650427952, 8640.870386944202, 8840.602172902234, 9135.177833994972, 4083.469149010669, 4160.687948403821, 4178.247915375262, 4178.519470260898, 4182.059036716714, 5234.450382709761, 5245.449227831099, 5279.868003299948, 5296.761645725875, 5393.7572809223675, 908.0374802709149, 931.9301052421096, 936.784539555906, 945.0171821305902, 945.5697657565792, 668.8327918020495, 693.4175292754111, 699.9160100787938, 706.7173130747742, 715.1204019056589, 11702.239354442105, 12162.452689628988, 12522.48830608097, 12611.432485538173, 12902.67743306406, 689.4518857508293, 699.9720011199597, 701.8596280743872, 712.6436781609195, 720.6504845150098, 5518.2826232590305, 5869.559783016291, 6246.812595622138, 6433.678316084177, 6548.27968923418, 102638.48680756698, 106125.0, 106235.0, 106402.0, 106420.46789766157, 90667.0, 93704.53147734217, 94976.52511737397, 96447.51776241214, 97636.0, 81115.59442202751, 81166.59416702879, 82058.58970705108, 84923.0, 85687.0, 11930.434956484398, 11950.46222919988, 12090.818637720617, 12204.2067265631, 12587.0, 36488.635113648525, 36632.45051324285, 36700.26599468049, 36845.44731828971, 38494.230115398095, 46200.30699539577, 46380.76809616065, 48475.51524484851, 61442.0, 71300.64349678218, 17942.820571794637, 18436.07819609041, 18557.257709692, 18559.72160417622, 18955.526111847314, 20410.693839592714, 21096.683549747075, 21168.894155529124, 21223.257185998416, 21284.148634054465, 17143.0, 17194.484165475056, 17263.913680431517, 17270.050147242022, 17362.65274694524, 18347.449576512725, 18375.0, 18451.16969736338, 18611.720824187378, 18647.347342843477, 18479.168437420078, 18518.629627407645, 18645.440636780917, 18734.0, 18823.529411764815, 12677.429515671633, 12886.162399444007, 13090.280034597808, 13142.34288285601, 13202.867971320164, 13950.080009571173, 14388.35252413623, 14408.927955360155, 15117.54647360581, 15641.765373519635], "value": 9211.30402405709, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 110.0, 101.0, 107.0, 110.0, 109.0, 110.0, 98.0, 109.0, 110.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 146.0, 180.0, 126.0, 149.0, 146.0, 118.0, 175.0, 118.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 164.0, 163.0, 165.0, 171.0, 166.0, 168.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 175.0, 76.0, 75.0, 76.0, 75.0, 153.0, 79.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 130.0, 91.0, 79.0, 80.0, 131.0, 79.0, 79.0, 137.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 152.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 57.0, 56.0, 56.0, 55.0, 55.0, 58.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 89.0, 78.0, 88.0, 89.0, 89.0, 78.0, 77.0, 98.0, 79.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 128.0, 131.0, 137.0, 135.0, 127.0, 131.0, 127.0, 126.0, 163.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 194.0, 179.0, 179.0, 180.0, 177.0, 199.0, 179.0, 171.0, 169.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 69.0, 64.0, 66.0], "value": 67.0, "unit": "score"}]}]} 03:57:43 INFO - Return code: 0 03:57:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:43 INFO - # TBPL SUCCESS # 03:57:43 INFO - Running post-action listener: _package_coverage_data 03:57:43 INFO - Running post-action listener: _resource_record_post_action 03:57:43 INFO - [mozharness: 2017-08-05 10:57:43.217580Z] Finished run-tests step (success) 03:57:43 INFO - Running post-run listener: _resource_record_post_run 03:57:43 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 431579136; Read time: 308; Write time: 454732 03:57:43 INFO - TinderboxPrint: CPU usage
13.2% 03:57:43 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 308 03:57:43 INFO - TinderboxPrint: I/O write bytes / time
431,579,136 / 454,732 03:57:43 INFO - TinderboxPrint: CPU idle
8,258.6 (86.8%) 03:57:43 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 03:57:43 INFO - TinderboxPrint: Swap in / out
0 / 0 03:57:43 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 4096; Write bytes: 106557440; Read time: 40; Write time: 147900 03:57:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:57:43 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 323743744; Read time: 252; Write time: 306716 03:57:43 INFO - Running post-run listener: _upload_blobber_files 03:57:43 INFO - Blob upload gear active. 03:57:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:43 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 03:57:43 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'] 03:57:43 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 03:57:44 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:45 INFO - (blobuploader) - INFO - Done attempting. 03:57:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:57:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:46 INFO - (blobuploader) - INFO - Done attempting. 03:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:53 INFO - (blobuploader) - INFO - Done attempting. 03:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:53 INFO - (blobuploader) - INFO - Done attempting. 03:57:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:53 INFO - Return code: 0 03:57:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3802862af1eebb231cadc7e6074798cfad92abc792bb09ecb93ac806742dd3b8d932da5715e3af53285ce9d5419f33724b7dc45b9d4c89574bcb0b83d669fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cac3fd4366f370d4cd9ede02c54d1d5e0eb1ced7e7493a16fbf6389bfa747068e02f9e2c29ae05e22a9694ca499d871af6e79fc091300fdcf2c830455d250d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/555f7fd573edda96a79881d21548fb1a600584f20221e58ef83c6a1271c3455cfa10a83c64b5bf45f390202f36213b7abee5c15889bdba6f6dd052c10fa1ea95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c97d5adf168b014b1179cf673a61b9d76dce31913c94dc565d8611dc8d13b357628ae9f10268f37ee853595b50e46410d749699f06a4111aad6aa355cb24f40"} 03:57:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:53 INFO - Contents: 03:57:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3802862af1eebb231cadc7e6074798cfad92abc792bb09ecb93ac806742dd3b8d932da5715e3af53285ce9d5419f33724b7dc45b9d4c89574bcb0b83d669fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cac3fd4366f370d4cd9ede02c54d1d5e0eb1ced7e7493a16fbf6389bfa747068e02f9e2c29ae05e22a9694ca499d871af6e79fc091300fdcf2c830455d250d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/555f7fd573edda96a79881d21548fb1a600584f20221e58ef83c6a1271c3455cfa10a83c64b5bf45f390202f36213b7abee5c15889bdba6f6dd052c10fa1ea95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c97d5adf168b014b1179cf673a61b9d76dce31913c94dc565d8611dc8d13b357628ae9f10268f37ee853595b50e46410d749699f06a4111aad6aa355cb24f40"} 03:57:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:53 INFO - Copying logs to upload dir... 03:57:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.905955 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-05 03:57:52.168160) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:52.171802) ========= 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-1501917258.600740-194931230 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/f3802862af1eebb231cadc7e6074798cfad92abc792bb09ecb93ac806742dd3b8d932da5715e3af53285ce9d5419f33724b7dc45b9d4c89574bcb0b83d669fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cac3fd4366f370d4cd9ede02c54d1d5e0eb1ced7e7493a16fbf6389bfa747068e02f9e2c29ae05e22a9694ca499d871af6e79fc091300fdcf2c830455d250d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/555f7fd573edda96a79881d21548fb1a600584f20221e58ef83c6a1271c3455cfa10a83c64b5bf45f390202f36213b7abee5c15889bdba6f6dd052c10fa1ea95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c97d5adf168b014b1179cf673a61b9d76dce31913c94dc565d8611dc8d13b357628ae9f10268f37ee853595b50e46410d749699f06a4111aad6aa355cb24f40"} build_url:https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3802862af1eebb231cadc7e6074798cfad92abc792bb09ecb93ac806742dd3b8d932da5715e3af53285ce9d5419f33724b7dc45b9d4c89574bcb0b83d669fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cac3fd4366f370d4cd9ede02c54d1d5e0eb1ced7e7493a16fbf6389bfa747068e02f9e2c29ae05e22a9694ca499d871af6e79fc091300fdcf2c830455d250d0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/555f7fd573edda96a79881d21548fb1a600584f20221e58ef83c6a1271c3455cfa10a83c64b5bf45f390202f36213b7abee5c15889bdba6f6dd052c10fa1ea95", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c97d5adf168b014b1179cf673a61b9d76dce31913c94dc565d8611dc8d13b357628ae9f10268f37ee853595b50e46410d749699f06a4111aad6aa355cb24f40"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:52.196407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:52.196760) ========= 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-1501917258.600740-194931230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:52.279160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 03:57:52.279460) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 03:57:52.279767) ========= ========= Total master_lag: 0.15 =========