builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1501929415.73 results: success (0) revision: a9182f92641b24d0a972886aed27e784004a343f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.727833) ========= 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.728285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.730557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.747439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.747789) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-05 03:36:56-- 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% 54.6M=0s 2017-08-05 03:36:56 (54.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.934573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.935015) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020085 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:55.991973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-05 03:36:55.992314) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-05 03:36:57,096 truncating revision to first 12 chars 2017-08-05 03:36:57,096 Setting DEBUG logging. 2017-08-05 03:36:57,096 attempt 1/10 2017-08-05 03:36:57,096 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,258 unpacking tar archive at: mozilla-central-a9182f92641b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.550328 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-05 03:36:57.569935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.570266) ========= script_repo_revision: a9182f92641b24d0a972886aed27e784004a343f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.570686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.570987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 03:36:57.579927) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-05 03:36:57.580237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:58 INFO - MultiFileLogger online at 20170805 03:36:58 in /builds/slave/test 03:36:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:36:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:58 INFO - {'append_to_log': False, 03:36:58 INFO - 'base_work_dir': '/builds/slave/test', 03:36:58 INFO - 'blob_upload_branch': 'Firefox', 03:36:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:58 INFO - 'branch': 'Firefox', 03:36:58 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:58 INFO - 'code_coverage': False, 03:36:58 INFO - 'config_files': ('talos/linux_config.py',), 03:36:58 INFO - 'default_actions': ('clobber', 03:36:58 INFO - 'read-buildbot-config', 03:36:58 INFO - 'download-and-extract', 03:36:58 INFO - 'populate-webroot', 03:36:58 INFO - 'create-virtualenv', 03:36:58 INFO - 'install', 03:36:58 INFO - 'setup-mitmproxy', 03:36:58 INFO - 'run-tests'), 03:36:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:58 INFO - 'disable_ccov_upload': False, 03:36:58 INFO - 'download_minidump_stackwalk': True, 03:36:58 INFO - 'download_symbols': 'ondemand', 03:36:58 INFO - 'enable_stylo': False, 03:36:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:58 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:58 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:58 INFO - 'gecko_profile': False, 03:36:58 INFO - 'gecko_profile_interval': 0, 03:36:58 INFO - 'installer_path': 'installer.exe', 03:36:58 INFO - 'log_level': 'info', 03:36:58 INFO - 'log_name': 'talos', 03:36:58 INFO - 'log_to_console': True, 03:36:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:58 INFO - 'opt_config_files': (), 03:36:58 INFO - 'pip_index': False, 03:36:58 INFO - 'suite': 'dromaeojs-e10s', 03:36:58 INFO - 'system_bits': '32', 03:36:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:58 INFO - 'title': 'talos-linux64-ix-034', 03:36:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:58 INFO - 'use_talos_json': True, 03:36:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:58 INFO - 'work_dir': 'build'} 03:36:58 INFO - [mozharness: 2017-08-05 10:36:58.779557Z] Running clobber step. 03:36:58 INFO - Running pre-action listener: _resource_record_pre_action 03:36:58 INFO - Running main action method: clobber 03:36:58 INFO - rmtree: /builds/slave/test/build 03:36:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:59 INFO - Running post-action listener: _resource_record_post_action 03:36:59 INFO - [mozharness: 2017-08-05 10:36:59.815611Z] Finished clobber step (success) 03:36:59 INFO - [mozharness: 2017-08-05 10:36:59.815714Z] Running read-buildbot-config step. 03:36:59 INFO - Running pre-action listener: _resource_record_pre_action 03:36:59 INFO - Running main action method: read_buildbot_config 03:36:59 INFO - Using buildbot properties: 03:36:59 INFO - { 03:36:59 INFO - "project": "", 03:36:59 INFO - "product": "firefox", 03:36:59 INFO - "who": "archaeopteryx@coole-files.de", 03:36:59 INFO - "installer_path": "public/build/target.tar.bz2", 03:36:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:36:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:36:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:36:59 INFO - "stage_platform": "linux64-stylo", 03:36:59 INFO - "basedir": "/builds/slave/test", 03:36:59 INFO - "buildnumber": 258, 03:36:59 INFO - "platform": "ubuntu64_hw_stylo", 03:36:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:36:59 INFO - "slavebuilddir": "test", 03:36:59 INFO - "taskId": "UrP-eoByQyiHzJ633CQtDg", 03:36:59 INFO - "branch": "mozilla-central", 03:36:59 INFO - "script_repo_revision": "production", 03:36:59 INFO - "revision": "a9182f92641b24d0a972886aed27e784004a343f", 03:36:59 INFO - "slavename": "talos-linux64-ix-034", 03:36:59 INFO - "repo_path": "mozilla-central" 03:36:59 INFO - } 03:36:59 INFO - Finding installer, test and symbols from parent task. 03:36:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrP-eoByQyiHzJ633CQtDg'}, attempt #1 03:37:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UrP-eoByQyiHzJ633CQtDg'}, 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.151690Z] Finished read-buildbot-config step (success) 03:37:01 INFO - [mozharness: 2017-08-05 10:37:01.151910Z] 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:02 INFO - Content-Length response header: 54284636 03:37:02 INFO - Bytes received: 54284636 03:37:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:37:13 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:13 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:13 INFO - Fetch https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.common.tests.zip into memory 03:37:14 INFO - Content-Length response header: 54284636 03:37:14 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:28 INFO - Downloaded 61835624 bytes. 03:37:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 03:37:28 INFO - mkdir: /builds/slave/test/properties 03:37:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:28 INFO - Contents: 03:37:28 INFO - build_url:https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 03:37:28 INFO - Running post-action listener: _resource_record_post_action 03:37:28 INFO - Running post-action listener: set_extra_try_arguments 03:37:28 INFO - [mozharness: 2017-08-05 10:37:28.727732Z] Finished download-and-extract step (success) 03:37:28 INFO - [mozharness: 2017-08-05 10:37:28.727830Z] Running populate-webroot step. 03:37:28 INFO - Running pre-action listener: _resource_record_pre_action 03:37:28 INFO - Running main action method: populate_webroot 03:37:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:37:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:37:28 INFO - 'tests': ['damp', 'tps']}, 03:37:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:37:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:37:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:37:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:28 INFO - 'ts_paint', 03:37:28 INFO - 'tpaint', 03:37:28 INFO - 'sessionrestore', 03:37:28 INFO - 'sessionrestore_many_windows', 03:37:28 INFO - 'sessionrestore_no_auto_restore', 03:37:28 INFO - 'tabpaint']}, 03:37:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:37:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:37:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:28 INFO - 'tsvgr_opacity', 03:37:28 INFO - 'tart', 03:37:28 INFO - 'tscrollx', 03:37:28 INFO - 'tsvg_static']}, 03:37:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:37:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:28 INFO - 'talos_options': ['--mitmproxy', 03:37:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:28 INFO - '--firstNonBlankPaint'], 03:37:28 INFO - 'tests': ['tp6_google', 03:37:28 INFO - 'tp6_youtube', 03:37:28 INFO - 'tp6_amazon', 03:37:28 INFO - 'tp6_facebook']}, 03:37:28 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:28 INFO - 'talos_options': ['--stylo', 03:37:28 INFO - '--mitmproxy', 03:37:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:28 INFO - '--firstNonBlankPaint'], 03:37:28 INFO - 'tests': ['tp6_google', 03:37:28 INFO - 'tp6_youtube', 03:37:28 INFO - 'tp6_amazon', 03:37:28 INFO - 'tp6_facebook']}, 03:37:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:37:28 INFO - 'talos_options': ['--stylo', 03:37:28 INFO - '--stylo-threads=1', 03:37:28 INFO - '--mitmproxy', 03:37:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:37:28 INFO - '--firstNonBlankPaint'], 03:37:28 INFO - 'tests': ['tp6_google', 03:37:28 INFO - 'tp6_youtube', 03:37:28 INFO - 'tp6_amazon', 03:37:28 INFO - 'tp6_facebook']}, 03:37:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:37:28 INFO - 'talos_options': ['--xperf_path', 03:37:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:28 INFO - 'tests': ['tp5n']}}} 03:37:28 INFO - Running post-action listener: _resource_record_post_action 03:37:28 INFO - [mozharness: 2017-08-05 10:37:28.736179Z] Finished populate-webroot step (success) 03:37:28 INFO - [mozharness: 2017-08-05 10:37:28.736269Z] Running create-virtualenv step. 03:37:28 INFO - Running pre-action listener: _resource_record_pre_action 03:37:28 INFO - Running main action method: create_virtualenv 03:37:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37:28 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:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:37:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:28 INFO - Using real prefix '/usr' 03:37:28 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 03:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:31 INFO - '_': '/tools/buildbot/bin/python'} 03:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:31 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:31 INFO - Cleaning up... 03:37:31 INFO - Return code: 0 03:37:31 INFO - Installing psutil>=3.1.1 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', '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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 03:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:31 INFO - '_': '/tools/buildbot/bin/python'} 03:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:31 INFO - Downloading/unpacking psutil>=3.1.1 03:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:34 INFO - Installing collected packages: psutil 03:37:34 INFO - Running setup.py install for psutil 03:37:34 INFO - building 'psutil._psutil_linux' extension 03:37:34 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:34 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:34 INFO - building 'psutil._psutil_posix' extension 03:37:34 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:34 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:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:34 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 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:36 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:36 INFO - Installing collected packages: mozsystemmonitor 03:37:36 INFO - Running setup.py install for mozsystemmonitor 03:37:36 INFO - Successfully installed mozsystemmonitor 03:37:36 INFO - Cleaning up... 03:37:36 INFO - Return code: 0 03:37:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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:36 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:36 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:36 INFO - Using env: {'DISPLAY': ':0', 03:37:36 INFO - 'HOME': '/home/cltbld', 03:37:36 INFO - 'LANG': 'en_US.UTF-8', 03:37:36 INFO - 'LANGUAGE': 'en_US:en', 03:37:36 INFO - 'LOGNAME': 'cltbld', 03:37:36 INFO - 'MAIL': '/var/mail/cltbld', 03:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:36 INFO - 'MOZ_NO_REMOTE': '1', 03:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:36 INFO - 'NO_EM_RESTART': '1', 03:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:36 INFO - 'PWD': '/builds/slave/test', 03:37:36 INFO - 'SHELL': '/bin/bash', 03:37:36 INFO - 'SHLVL': '1', 03:37:36 INFO - 'TERM': 'linux', 03:37:36 INFO - 'TMOUT': '86400', 03:37:36 INFO - 'USER': 'cltbld', 03:37:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 03:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:36 INFO - '_': '/tools/buildbot/bin/python'} 03:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:36 INFO - Downloading/unpacking 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:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:37 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 03:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:37 INFO - '_': '/tools/buildbot/bin/python'} 03:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:38 INFO - Cleaning up... 03:37:38 INFO - Return code: 0 03:37:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:38 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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:38 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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:38 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 03:37:38 INFO - 'HOME': '/home/cltbld', 03:37:38 INFO - 'LANG': 'en_US.UTF-8', 03:37:38 INFO - 'LANGUAGE': 'en_US:en', 03:37:38 INFO - 'LOGNAME': 'cltbld', 03:37:38 INFO - 'MAIL': '/var/mail/cltbld', 03:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:38 INFO - 'MOZ_NO_REMOTE': '1', 03:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:38 INFO - 'NO_EM_RESTART': '1', 03:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:38 INFO - 'PWD': '/builds/slave/test', 03:37:38 INFO - 'SHELL': '/bin/bash', 03:37:38 INFO - 'SHLVL': '1', 03:37:38 INFO - 'TERM': 'linux', 03:37:38 INFO - 'TMOUT': '86400', 03:37:38 INFO - 'USER': 'cltbld', 03:37:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 03:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:38 INFO - '_': '/tools/buildbot/bin/python'} 03:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:37:38 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:38 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 - 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:38 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 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:40 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 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-mwOl69-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-Uq0mIs-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-ZEuxk6-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-dHUfCy-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-wuUf7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:41 INFO - Running setup.py (path:/tmp/pip-WbRP3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:41 INFO - Running setup.py (path:/tmp/pip-rrl7Fd-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-mgqLEI-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-hutg0R-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-ErV9s0-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-JJRN3j-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-WLKjjR-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-irPnsU-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-jVaIiR-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-WWfV7E-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-0oS8rG-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-8TIe7z-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:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:42 INFO - Running setup.py install for mozcrash 03:37:42 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:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:43 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 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-ahsMTK-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-qbXnlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:44 INFO - Running setup.py (path:/tmp/pip-2OBZxZ-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-c1IVAT-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-Mfs5vF-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-8XxZpI-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-Bx6SIY-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-I8tYcQ-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-xyZ9W1-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-Dq_n9s-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-O_DMKQ-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-hoMz2N-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-QLbSH5-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-941IuP-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-eFnX2B-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:45 INFO - Running setup.py (path:/tmp/pip-gMpgPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:45 INFO - Running setup.py (path:/tmp/pip-auvksk-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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 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 0x10941f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1260a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1403d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 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.381776Z] Finished create-virtualenv step (success) 03:37:49 INFO - [mozharness: 2017-08-05 10:37:49.382248Z] 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.805858Z] Finished install step (success) 03:38:07 INFO - [mozharness: 2017-08-05 10:38:07.806152Z] 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.807356Z] Finished setup-mitmproxy step (success) 03:38:07 INFO - [mozharness: 2017-08-05 10:38:07.807575Z] 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 0x1400eb0>, '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 0x1401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1402240>, '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', '--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-034', '--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 --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-034 --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 - 'STYLO_FORCE_ENABLED': '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': 'd6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296', 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', '--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-034', '--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:50110' 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:50110/getInfo.html -profile /tmp/tmpRuRyHg/profile 03:38:08 INFO - TEST-INFO | started process 26478 (/builds/slave/test/build/application/firefox/firefox http://localhost:50110/getInfo.html) 03:38:14 INFO - TEST-INFO | 26478: 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 26703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRuRyHg/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 26703 | 03:38:15 INFO - PID 26703 | (/builds/slave/test/build/application/firefox/firefox:26757): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:38:15 INFO - PID 26703 | 03:38:25 INFO - PID 26703 | RSS: Main: 173801472 03:38:25 INFO - PID 26703 | 03:41:25 INFO - PID 26703 | Cycle 1(1): loaded http://localhost:50110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50110/tests/dromaeo/cssquery-ext.html) 03:41:26 INFO - PID 26703 | RSS: Main: 173559808 03:41:26 INFO - PID 26703 | 03:44:28 INFO - PID 26703 | Cycle 1(1): loaded http://localhost:50110/tests/dromaeo/cssquery-ext.html (next: http://localhost:50110/tests/dromaeo/cssquery-jquery.html) 03:44:29 INFO - PID 26703 | RSS: Main: 171372544 03:44:29 INFO - PID 26703 | 03:47:31 INFO - PID 26703 | Cycle 1(1): loaded http://localhost:50110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50110/tests/dromaeo/cssquery-mootools.html) 03:47:31 INFO - PID 26703 | RSS: Main: 174481408 03:47:31 INFO - PID 26703 | 03:50:33 INFO - PID 26703 | Cycle 1(1): loaded http://localhost:50110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50110/tests/dromaeo/cssquery-prototype.html) 03:50:34 INFO - PID 26703 | RSS: Main: 173756416 03:50:34 INFO - PID 26703 | 03:53:38 INFO - PID 26703 | Cycle 1(1): loaded http://localhost:50110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50110/tests/dromaeo/cssquery-yui.html) 03:53:38 INFO - PID 26703 | RSS: Main: 174891008 03:53:38 INFO - PID 26703 | 03:56:40 INFO - PID 26703 | Cycle 1(1): loaded http://localhost:50110/tests/dromaeo/cssquery-yui.html (next: http://localhost:50110/tests/dromaeo/cssquery-dojo.html) 03:56:40 INFO - PID 26703 | RSS: Main: 177795072 03:56:40 INFO - PID 26703 | 03:56:40 INFO - PID 26703 | __start_tp_report 03:56:40 INFO - PID 26703 | _x_x_mozilla_page_load 03:56:40 INFO - PID 26703 | _x_x_mozilla_page_load_details 03:56:40 INFO - PID 26703 | |i|pagename|runs| 03:56:40 INFO - PID 26703 | |0;dojo.html;3146.8111913285206;3151.558781770551;3175.888843890464;3210.983945080274;3217.067050555339;6150.169727086842;6191.721372538235;6213.844653883655;6217.689115544227;6229.813105606839;6250.374962503747;6250.406211409909;6262.248530176374;6280.623162610246;6287.497000239981;5731.541476681877;5732.398098199692;5744.253247077874;5793.275840519935;5802.042662960606;5729.455701708331;5729.914051289234;5753.884922301551;5771.855703607402;5815.447532484428;5827.67947762875;5837.503812175949;5844.357120716739;5888.499477544414;5889.411058894119;5812.738426770806;5892.793752218695;5892.88214235715;5908.822735317947;5912.320083190445;5587.106063029936;5732.484076433099;5816.680082595455;5826.329972053226;5829.446202610745;6043.365446628085;6077.513798896122;6147.139400483936;6164.722587483574;6208.844778880519;6700.061991321219;6758.087658166134;6773.4242589379965;6781.932180678179;6813.727450901958;6791.490638202105;6813.318668133147;6856.691448884762;6899.068625735512;6913.2049814270995;6165.784197553064;6278.6546739929745;6303.7163327649905;6368.840778980516;6368.904466432961;6890.896636550456;6892.207396149507;6912.412444942236;6918.204406493318;6918.377346038881;6500.902486462707;6519.282878883319;6575.473962083118;6577.440917521969;6578.375054369827;6362.681865906686;6648.767293144717;6743.393094621508;6772.932270677329;6821.045053692487;6672.132622759011;6672.299408562031;6744.62904540255;6810.114685090906;6811.944148656966;6636.634985075771;6707.49693772969;6716.865662686719;6735.831604209934;6815;5419.945800542023;5433.0763770159165;5454.809081682122;5507.669539827623;5526.944730552643;4677.134730074947;4691.061787642485;4725.9527404726205;4746.359241502422;4747.240441529339;5767.567432442584;5848.678322692293;5852.882942341214;5853.560982926298;5863.853403664943;6689.565178263495;6695.464362851058;6700.798976030727;6768.763093291711;6774.288699686561;5744.540436765049;5765.798197063083;5776.884462310731;5811.27359080115;5825.941740582624;5950.2264705587995;5950.285965684059;5954.940450595525;5960.4635582797755;5964.821055368259;6471.546991710535;6525.314841941623;6557.803265902031;6558.672066396661;6563.868722625521;6750.729970801113;6773.322667733188;6773.525853190229;6776.254611992776;6936.167659880846;6542.149520562297;6543.345665433419;6559.573627714183;6627.966860165669;6655.301193374626;6526.314736952551;6618.669066546557;6654.035164901159;6676.56602320867;6765.357291057342;6764.830879227862;6883.174019117738;6884.173899131936;6887.414569761627;6898.931010689829;6548.1814773153355;6591.176102987127;6636.933630663631;6637.734490620321;6641;6546.69066186774;6575.178102737158;6644.501662375244;6644.867102658017;6658.300878407697;6360.522960777867;6444.13004244421;6470.255920569007;6474.546781725422;6604.702788374439;6519.217693876765;6612.437942774918;6623.966880165761;6624.6025238485845;6628.072069910313;6310.810675679737;6363.872722545616;6390;6402.35976402356;6414.294427612866 03:56:40 INFO - PID 26703 | |1;ext.html;761.7143571160815;818.9590520473977;826.7685048186509;1159.5767544846128;1186.3534373766308;30817;42822;43358.34962475562;43589.78205108978;43592.564074359245;43977.78011109948;44129;44452.777736111355;44508.77745611275;44510;7750.961245193766;7945.404094692893;7945.9602701986405;7952.085510166318;7953.4432589718745;7742.109657389387;7821.217878212162;7869.095054068798;7889.171636978121;7903.012123484565;7891.8421631567335;7921.04947406312;7928.484648497858;7969.9203007970045;7979.960100199491;7815.452918295721;7839.568823714693;7853.175416581291;7882.724104656367;7933.920660793405;7707.190744971754;7741.8451630967065;7759.612019399064;7779.37764978806;7780.649870755829;39153.80423097866;39370.21259574821;39383.40924886129;39403.21193576112;39414.40878386827;3637.854485820564;3669.7798132111893;3669.889903302905;3672.9081772955624;3678;30820.537691934638;31010;31112.377752444823;31209.375812483624;31244.375112497622;4890.73100979446;4950.851474455772;4961.18140506816;4984.352034235526;4994.150994330972;185974;186234;186587;186750;188423.99999999863;49263.261051084264;49503.50496494989;49657.255141172915;49939.75030124826;49947;50960.74519627378;51473.48526514762;51492.48507514952;51507;51649.48350516447;14166.929165354313;14214.360353784105;16453;16644.83355166457;16909;13800.585982420343;13951.441942322397;13953.372098255602;13959.092658977133;13959.371828267753;14534.85465145335;14542.491012814713;14574.19841908684;14720.190389528465;14880.181590012437;5787.88424231513;5909.704514774244;5925.674087925119;6007.36922623127;6020.187274717945;983.6360546597662;1005.2360206243162;1008.5159123620704;1011.716719318592;1033.9896601033893;23197;29082.56376154317;29263.122106336843;29373.559396609067;29760.55359169614;1069.5828626835541;1083.0956151613334;1084.766775143348;1102.5644870276196;1111.8943700348455;12042.15704900666;12285.815712764315;12330.753384932252;12382.504699811907;12392.62822115338;235469;240721;240772;242136;242630;52608.47391526036;53105;53299.733501332244;53433.198502022504;53470;1452.6532603393246;1460.4523303761089;1467.8678918897351;1476.60131764423;1478.1426772471941;22413.887930560242;22432.32703018912;22490.437739056;22553.88723056374;22723.431914201617;36177.819110904275;36373.27253454863;36381.818090910434;36456.27087458183;36457.63542364648;201971;202190;202492;202921;202923;33229.16927076843;36925.44611830771;38796.6120338793;38910.4163437543;39056.80471597738;45742.08515829731;47920.28119578279;47975.76012119917;48388.5161148384;48787.26819097645;34188.31623367469;34434;34478.65521344855;34546.48180277348;35347.82326088353;33811.83094084514;34031;34148.31703365869;34905.47641785324;35020.29959400747;37951.62048379481;38102.428463573626;38358.42462363011;38456.423153652155;38469.42295865508;33403.83298083494;33648.663513364554;33762.49356259707;34080;34385.31229375448;24199.395015124763;24408.26775196747;24574.262772116865;24704.382390440383;24802.50394992126 03:56:40 INFO - PID 26703 | |2;jquery.html;603.4357875386514;603.7343568829712;605.5851741557034;611.5077362723009;621.4282859769013;22402.215922442698;22825.201117960874;23010.88494557529;23014.88492557535;23021;21489.785102148973;21511.139554417805;22572.209972650962;27369.45261094777;27661.86169069157;6372.394622510866;6518.641474718888;6539.476841852664;6539.836504087389;6548.967255163718;5912.467877890989;6407.551471397004;6454.612723236621;6455.806325810233;6489.286178520359;6436.420722135007;6460.321666225049;6461.709223084949;6464.353564643545;6465.967670161643;6430.517711171634;6438.452731517803;6444.097826304321;6448.774292899773;6449.516286278525;5862.589618726691;5899.351071382144;5934.902043122036;5937.584369094165;5970.313413957407;29078.41843163146;29210.41579168405;29766.404671906657;29800.552991705143;30807.075787726404;1907.3324336482258;1942.0483962858239;1956.8141026602593;1965.7149713291635;1978.0900785638623;19540.609187816164;19633.410997670093;20020.29928952494;20185.293514726913;20643.483912902146;2433.513297340539;2438.829281950264;2477.814163937712;2490.2280293109193;2500.5124000819847;117692;122755.38622306832;135269;141073.29463352618;144544;14556.297426346668;15268.694626107415;15551.533453996399;15666.921665391601;15717.921410393104;21451.356459305935;21457.892710536347;21491.462713431978;21494.57010859774;21627.35117946464;10261.794764104676;10309.381437113798;10389.480525973671;10484.056434920894;10528.36829790215;9722.173615242642;9759.316847820726;9820.361676491148;9871.358361706467;9999.700008999742;9182.265418766483;9238.214751746176;9441.386309889835;9476.194523465583;9522.761930951781;2689;2700.4464084862557;2755.917322480329;2772.4039331543413;2888.176869592156;954.5513608603945;992.3400938376044;997.3417544420647;999.7000899730052;1001.234055947201;19652.901735491232;19844.801551984583;19989.737611653418;20186.09162587687;20361.490962725755;1052.7947050325267;1065.8880817514205;1067.80779459698;1068.791585640808;1079.7894410590018;10945.845345217864;11140.721481963015;11218.495167717472;11232.10143188543;11279.548818047351;466200;466308;471301;474545;480890;113151;122214.38892805479;122510;122746.38626806988;122748;1214.4717048084112;1217.933013684256;1247.6756043428593;1253.2981530343036;1255.1276862580419;17484.737728933822;17727.91136044363;17849.910750446164;17866.91066544659;17978.460646180636;53394.19908701295;54693.72653136709;55727;56000.719996399755;57842.13236801367;75956;78032;78541;78958.6052069736;79250.60374698321;14729.968902176744;14991.250437477864;15618.9219053904;15634.45279415215;15663.608409789846;23967.760322396553;24294.514109717355;24372.26883193507;24391.756082439657;24415.877920610284;18834.905825470785;19126.617467650292;19225.13486893121;19292;19383.127759250587;15822.446214382442;16707.749383759012;17015.7447638288;17571.209295581986;17591.296348146443;19061.52346191301;19302.613947720685;19611.607767844278;19611.901940490206;19682.409527714193;14523.564293071226;15278.694426111193;15377.538673839803;15383.230838458256;15421.383144674088;18132.909335453238;18289.085545722395;18731;18830.152643131365;18857.24571017199 03:56:40 INFO - PID 26703 | |3;mootools.html;1350.6960933789899;1352.9526466573673;1399.6221020324513;1401.824771903512;1404.1996062244511;13403.396847141878;13907.860921390795;13966.162030278165;13971.231582262972;13978.09142405743;13913.58259252224;14340.641483962907;14361.425542978295;14385.352659130338;14386.712265754679;2711.227300219443;2750.724927507243;2752.7384898434616;2754.820936639112;2754.9173524794287;2634.3150780797037;2831.504486714827;2831.5469524876025;2834.63149790528;2837.645294338208;2703.3106557827728;2710.11921125634;2717.877695503707;2748.395353022332;2750.642416485854;2597.948041039169;2613.908513202038;2629.32952097214;2634.657494525709;2665.9466810663776;2556.322574517754;2603.2320465462735;2636.868156592163;2665.7200993895553;2669.2125822882103;13472.326383680776;13799.517016904461;13809.378577964017;13848.86151138496;13889.79165312521;7315.561066335984;7548.396128309722;7549.660265288076;7565.43259255558;7583.165851756303;5003.924941125886;5140.588752899759;5238.188080847474;5284.656497327662;5351.411344752074;1828.2047309420445;1833.2941817400263;1872.7659042619673;1882.8681992260547;1912.2351059576142;21110.89444552783;23192.072317107297;23412.64881026786;23444.882775586182;23460.882695586584;6359.777407790705;6447.2263328400895;6664.200295964419;6715.127033485714;6717.361850624281;15087.094774313577;15104.320305586274;15110.093394396372;15148.772768408482;15990.680186396206;7544.396448284124;7779.260970207822;7786.1435242123325;7794;7814.648340824677;7179.389751871149;7189.173245076779;7202.53183543068;7252.093488313961;7264.382527485117;4821.5178482152205;4974.577160941288;5010.574101201366;5027.145385284511;5058.544730974157;1417.666848290651;1420.1195258939524;1444.50886698523;1444.9638759030897;1455.4251070826965;876.6186708781573;907.5552979040223;911.6900253913701;919.1176470588176;920.5949382271779;6961.303869612998;7060.5410648308725;7101.147862256562;7126.180489243803;7146.892796608055;976.6874600128033;1000.3597697473623;1005.7133716890651;1012.767063575367;1014.4927536231884;4807.855764327076;4959.62802789785;4989.525995030466;5014.774335154927;5246.23929530216;18998.24007039703;19076.71384929227;19435.611287774165;19492.41522754291;19655.508612284808;18567.72148417775;18995.43013709591;19470.902645486683;19481;19519.707204391947;10793.244472886823;10898.12814974816;10904;10974.890251097388;10975.28660637056;7426.108866936002;7775.727849525239;7827.373810095065;7929.5242285463055;7935.246151615587;16485.17574121313;16637.41769038078;16930.83069169342;17014.31942722327;17571.297148113932;16905.66188676195;17172.398966036628;17259;17434;17592.208350623998;11465;11525.020373268366;11565.363904985306;11715.941420292844;11721.589744358907;12999.1550549214;13063.673408164872;13146.474141034634;13152.802707959198;13158.60524184276;10297.17622590176;10380.32527885685;10453.738656533344;10489.790204196026;10686.198535110054;10252.38485690861;10393.58425662965;10429.634962776267;10440.530176142243;10609.522571484147;9007.189352958265;9043.728688139367;9110.90889091127;9141.26869850397;9144;6857.108575885103;7002.509824312249;7024.227334993045;7042.507024508235;7085.858282834211;6852.040714300102;6939.653017349214;6958.617276049866;6994;7032.894506582507 03:56:40 INFO - PID 26703 | |4;prototype.html;468.4495717531899;483.83791429871;495.38819557846034;496.0995792636365;502.4874627879563;6209.441150296478;6292.413324405091;6309.3059763426045;6325;6343.968280158604;5997.940020599804;6195.2255968004;6216.968915155418;6221.595596286238;6228.003519436891;4898.461169271377;4954.925676114861;4968.701877887338;4978.850634480971;5002.349694539705;4970.751462426882;4971.627127965399;4985.825496107637;4993.850184494471;5024.371953505812;4773.64197685175;4840.346553215324;4883;4938.851834444972;4952.479989601094;4871.780769865347;4877.122118018738;4908.263760435963;4970.539582906485;4994.35073440454;4402.3836662867225;4415.933760993587;4424.159409712177;4430.579094985971;4442.577955094261;6067.908981365283;6090.147379366892;6112.821332906908;6125.509959203253;6145.815625531197;5706.600537962344;5707.942920570824;5744.741486633112;5759.164921086419;5773.3442616396505;6593;6601.471882249409;6614.140161778986;6626.801195964129;6671.466282697373;4820.493848145929;4836.879078023042;4848.927266091011;4863.19757240055;4888.584470320027;6970;7044.189918159374;7049.519600883769;7085.433165346812;7099.964500177518;4951.870695600855;4958.454569997298;4979.278004689299;4981.526754958273;5061.898762024739;5018.42288136869;5023.899522009612;5065.240213967934;5077.923831142536;5098.770555325019;5716.28546431696;5723.971380143156;5737.540996720252;5778.3354914184565;5782.421757824184;6564.9671751640935;6645.335466453413;6668.899966500507;6696.497762667819;6771.153605799275;1667.4914151184005;1701.4470297153475;1718.8453039226529;1744.3284335530911;1755.824417558234;1133.1784456269138;1156.5951916829042;1200.699825043739;1210.2194084815244;1214.6173955204083;5742;5755;5783.826485205451;5786.594938354359;5828.358880523139;6712.664366781642;6733.528652994243;6736.46108311334;6760.7295708172105;6773.966130169318;5662.801801936995;5672.489475947102;5776.884462310731;5785.652860828363;5843.970780146157;3608.9819550902075;3612.83876607968;3614.710823134143;3632.4551317302617;3646.4894914711963;6481.740730370827;6492.610443373318;6556.24603170632;6592.351912021994;6623.801285961429;6911.481638877104;6979.232284448706;7010.509264351446;7016.456379596582;7045.401140903081;6465.579737317154;6472.5145614080075;6545.9018114728315;6587.934120658828;6629.668516574248;6588.308227636221;6693.690676716525;6717.56335838169;6741.696623652046;6763.256041835492;6688.498362622726;6700.731970721312;6718.7312507499155;6752.628605426552;6804.081449004321;6523.967380163259;6535.411812936859;6566.376194261537;6571.901421478778;6607.603543787388;4950.356453661001;4964.329815475009;4976.576990955809;4992.425871024879;4997.250412438163;6689.896167132563;6748;6755.662216889037;6759;6836.282190370139;6480.740770369132;6534.379233972765;6542.34576542342;6545.14913061299;6596.175478065242;6376.904346434714;6434.646094464662;6520.478361731145;6551.934480655133;6628.801135965929;6226.62640241587;6357.7139028742895;6415.524429381175;6462.773802917063;6479.708413121327;6323.652199129092;6392.9360706392345;6394.87210255783;6503.756204109574;6571.178602674666;6213.506885304777;6309.463695585927;6335.67377127012;6406.23125224976;6418.679066046586 03:56:41 INFO - PID 26703 | |5;yui.html;900.9774755631113;918.8208299381619;934.8083642853215;939.7556635274831;942.1567696911264;18809.529761755963;19800.40598782035;19809.900950495263;19814.70277945832;19817.900910495464;17714.1142942853;17835.82164178358;17868.374606888763;22439.887800560973;22444.8877755611;1044.9895501044987;1067.3649178738676;1067.5409573883228;1068.4444089073677;1075.6772968109574;1069.0485467933545;1069.0752499088271;1072.4798472740715;1072.7961687279392;1073.7798751256014;1064.2337516987757;1103.624767579023;1119.7648493816268;1127.836463712761;1142.2175809570472;1102.2339474065527;1106.1593189176244;1107.3909349857627;1108.146727020194;1108.2297803026859;796.8406318736276;801.6673080671515;804.7223707820792;805.613305613303;808.1635507250027;20148.798512014986;20329;20430.897845510677;20506.487337816525;20780.688289675665;21271.14915403382;21368.786312136992;21618.783812161833;22083.779162208495;22091.889540552354;16486.505404837873;16646.833531664648;16824.07467589282;16938.068406237653;17003.65992680152;3584.8566057357675;3620.7103431725664;3630.3828349180703;3630.9273814523826;3644.763090399142;127733.36133319366;128640;131402.68597314096;132915.33542332228;133404;16830;17015.82984170167;17116.91441542809;17137.400190993256;17450.47648570545;31567.21081972969;31793.84103079516;32195.195120122185;32361.676383235867;32443;8566.229039386486;8582.399232053696;8619.655213791504;8654.524001179996;8672.95663521691;4301.333293339538;4433.179861725591;4466.888327791831;4478.193925093449;4483.977580112144;5112.386513618315;5209.140491818807;5221.190715439113;5222.608304377187;5700.629459085146;1063.3619828103076;1075.2258373970728;1101.8126918423886;1101.9669409917556;1101.983470247947;674.0832467843728;689.6000319814495;691.8062942376142;704.4188544450849;711.8184862859938;11774.705632359259;12199.817002744965;12408.56570020045;12412.62762117138;12902.548410805577;676.8781619308473;687.0793137196181;688.7382794538044;692.3042342445809;692.5775277080977;5370.4361042090795;5373.247745315659;5629.944009404878;5771.538276937835;5927.022041363127;97421;98469.50765246128;98895;99968.50015749874;100294.49852750689;90880;94005.5299723497;95052;95363.52318238503;95477;79083.20916790873;81132.59433702912;81186.59406702929;84382;85909;10828.458577071273;11093.500792464198;12383.257004579755;12591.433385497492;12910;36156.27687446184;37359;37436;38066.80966595149;40159.3976090353;69797.95303070356;69928;70372.64813676104;71198;75444.86832697624;19693;19776.30782922591;19787.802121978595;19975.101120449322;20090.095945682187;20847.791522084586;21532.784672153706;21568.89215553912;21851.672224916958;21868.45328866791;18367.14289999115;18576.164072617034;18715.344962926232;18899.244030238635;19311.130999104793;18377.72433413473;18652.44042678722;18739.531511712317;18810.52973675669;18821.435356939313;18570.44288671342;19233.230670773013;19321.613567728848;19540.804591954467;19551.315703950295;13624.65938351549;13635.250061246727;13898.861011390161;14057.859421405656;14632.34154463073;14215.573532794033;14662.706745865236;14928.7760683592;15176.620584485476;15433.614159646098 03:56:41 INFO - PID 26703 | __end_tp_report 03:56:41 INFO - PID 26703 | __start_cc_report 03:56:41 INFO - PID 26703 | _x_x_mozilla_cycle_collect,364 03:56:41 INFO - PID 26703 | __end_cc_report 03:56:41 INFO - PID 26703 | __startTimestamp1501930600988__endTimestamp 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | ------- Summary: start ------- 03:56:41 INFO - PID 26703 | Number of tests: 6 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | [#0] dojo.html Cycles:165 Average:6209.20 Median:6444.13 stddev:729.00 (11.3%) stddev-sans-first:690.52 03:56:41 INFO - PID 26703 | Values: 3146.8 3151.6 3175.9 3211.0 3217.1 6150.2 6191.7 6213.8 6217.7 6229.8 6250.4 6250.4 6262.2 6280.6 6287.5 5731.5 5732.4 5744.3 5793.3 5802.0 5729.5 5729.9 5753.9 5771.9 5815.4 5827.7 5837.5 5844.4 5888.5 5889.4 5812.7 5892.8 5892.9 5908.8 5912.3 5587.1 5732.5 5816.7 5826.3 5829.4 6043.4 6077.5 6147.1 6164.7 6208.8 6700.1 6758.1 6773.4 6781.9 6813.7 6791.5 6813.3 6856.7 6899.1 6913.2 6165.8 6278.7 6303.7 6368.8 6368.9 6890.9 6892.2 6912.4 6918.2 6918.4 6500.9 6519.3 6575.5 6577.4 6578.4 6362.7 6648.8 6743.4 6772.9 6821.0 6672.1 6672.3 6744.6 6810.1 6811.9 6636.6 6707.5 6716.9 6735.8 6815.0 5419.9 5433.1 5454.8 5507.7 5526.9 4677.1 4691.1 4726.0 4746.4 4747.2 5767.6 5848.7 5852.9 5853.6 5863.9 6689.6 6695.5 6700.8 6768.8 6774.3 5744.5 5765.8 5776.9 5811.3 5825.9 5950.2 5950.3 5954.9 5960.5 5964.8 6471.5 6525.3 6557.8 6558.7 6563.9 6750.7 6773.3 6773.5 6776.3 6936.2 6542.1 6543.3 6559.6 6628.0 6655.3 6526.3 6618.7 6654.0 6676.6 6765.4 6764.8 6883.2 6884.2 6887.4 6898.9 6548.2 6591.2 6636.9 6637.7 6641.0 6546.7 6575.2 6644.5 6644.9 6658.3 6360.5 6444.1 6470.3 6474.5 6604.7 6519.2 6612.4 6624.0 6624.6 6628.1 6310.8 6363.9 6390.0 6402.4 6414.3 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | [#1] ext.html Cycles:180 Average:38672.63 Median:36377.55 stddev:54680.32 (150.3%) stddev-sans-first:54759.62 03:56:41 INFO - PID 26703 | Values: 761.7 819.0 826.8 1159.6 1186.4 30817.0 42822.0 43358.3 43589.8 43592.6 43977.8 44129.0 44452.8 44508.8 44510.0 7751.0 7945.4 7946.0 7952.1 7953.4 7742.1 7821.2 7869.1 7889.2 7903.0 7891.8 7921.0 7928.5 7969.9 7980.0 7815.5 7839.6 7853.2 7882.7 7933.9 7707.2 7741.8 7759.6 7779.4 7780.6 39153.8 39370.2 39383.4 39403.2 39414.4 3637.9 3669.8 3669.9 3672.9 3678.0 30820.5 31010.0 31112.4 31209.4 31244.4 4890.7 4950.9 4961.2 4984.4 4994.2 185974.0 186234.0 186587.0 186750.0 188424.0 49263.3 49503.5 49657.3 49939.8 49947.0 50960.7 51473.5 51492.5 51507.0 51649.5 14166.9 14214.4 16453.0 16644.8 16909.0 13800.6 13951.4 13953.4 13959.1 13959.4 14534.9 14542.5 14574.2 14720.2 14880.2 5787.9 5909.7 5925.7 6007.4 6020.2 983.6 1005.2 1008.5 1011.7 1034.0 23197.0 29082.6 29263.1 29373.6 29760.6 1069.6 1083.1 1084.8 1102.6 1111.9 12042.2 12285.8 12330.8 12382.5 12392.6 235469.0 240721.0 240772.0 242136.0 242630.0 52608.5 53105.0 53299.7 53433.2 53470.0 1452.7 1460.5 1467.9 1476.6 1478.1 22413.9 22432.3 22490.4 22553.9 22723.4 36177.8 36373.3 36381.8 36456.3 36457.6 201971.0 202190.0 202492.0 202921.0 202923.0 33229.2 36925.4 38796.6 38910.4 39056.8 45742.1 47920.3 47975.8 48388.5 48787.3 34188.3 34434.0 34478.7 34546.5 35347.8 33811.8 34031.0 34148.3 34905.5 35020.3 37951.6 38102.4 38358.4 38456.4 38469.4 33403.8 33648.7 33762.5 34080.0 34385.3 24199.4 24408.3 24574.3 24704.4 24802.5 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | [#2] jquery.html Cycles:180 Average:34508.11 Median:21502.85 stddev:79815.03 (371.2%) stddev-sans-first:79998.34 03:56:41 INFO - PID 26703 | Values: 603.4 603.7 605.6 611.5 621.4 22402.2 22825.2 23010.9 23014.9 23021.0 21489.8 21511.1 22572.2 27369.5 27661.9 6372.4 6518.6 6539.5 6539.8 6549.0 5912.5 6407.6 6454.6 6455.8 6489.3 6436.4 6460.3 6461.7 6464.4 6466.0 6430.5 6438.5 6444.1 6448.8 6449.5 5862.6 5899.4 5934.9 5937.6 5970.3 29078.4 29210.4 29766.4 29800.6 30807.1 1907.3 1942.0 1956.8 1965.7 1978.1 19540.6 19633.4 20020.3 20185.3 20643.5 2433.5 2438.8 2477.8 2490.2 2500.5 117692.0 122755.4 135269.0 141073.3 144544.0 14556.3 15268.7 15551.5 15666.9 15717.9 21451.4 21457.9 21491.5 21494.6 21627.4 10261.8 10309.4 10389.5 10484.1 10528.4 9722.2 9759.3 9820.4 9871.4 9999.7 9182.3 9238.2 9441.4 9476.2 9522.8 2689.0 2700.4 2755.9 2772.4 2888.2 954.6 992.3 997.3 999.7 1001.2 19652.9 19844.8 19989.7 20186.1 20361.5 1052.8 1065.9 1067.8 1068.8 1079.8 10945.8 11140.7 11218.5 11232.1 11279.5 466200.0 466308.0 471301.0 474545.0 480890.0 113151.0 122214.4 122510.0 122746.4 122748.0 1214.5 1217.9 1247.7 1253.3 1255.1 17484.7 17727.9 17849.9 17866.9 17978.5 53394.2 54693.7 55727.0 56000.7 57842.1 75956.0 78032.0 78541.0 78958.6 79250.6 14730.0 14991.3 15618.9 15634.5 15663.6 23967.8 24294.5 24372.3 24391.8 24415.9 18834.9 19126.6 19225.1 19292.0 19383.1 15822.4 16707.7 17015.7 17571.2 17591.3 19061.5 19302.6 19611.6 19611.9 19682.4 14523.6 15278.7 15377.5 15383.2 15421.4 18132.9 18289.1 18731.0 18830.2 18857.2 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | [#3] mootools.html Cycles:180 Average:8655.42 Median:2600.59 stddev:5897.20 (226.8%) stddev-sans-first:5888.20 03:56:41 INFO - PID 26703 | Values: 1350.7 1353.0 1399.6 1401.8 1404.2 13403.4 13907.9 13966.2 13971.2 13978.1 13913.6 14340.6 14361.4 14385.4 14386.7 2711.2 2750.7 2752.7 2754.8 2754.9 2634.3 2831.5 2831.5 2834.6 2837.6 2703.3 2710.1 2717.9 2748.4 2750.6 2597.9 2613.9 2629.3 2634.7 2665.9 2556.3 2603.2 2636.9 2665.7 2669.2 13472.3 13799.5 13809.4 13848.9 13889.8 7315.6 7548.4 7549.7 7565.4 7583.2 5003.9 5140.6 5238.2 5284.7 5351.4 1828.2 1833.3 1872.8 1882.9 1912.2 21110.9 23192.1 23412.6 23444.9 23460.9 6359.8 6447.2 6664.2 6715.1 6717.4 15087.1 15104.3 15110.1 15148.8 15990.7 7544.4 7779.3 7786.1 7794.0 7814.6 7179.4 7189.2 7202.5 7252.1 7264.4 4821.5 4974.6 5010.6 5027.1 5058.5 1417.7 1420.1 1444.5 1445.0 1455.4 876.6 907.6 911.7 919.1 920.6 6961.3 7060.5 7101.1 7126.2 7146.9 976.7 1000.4 1005.7 1012.8 1014.5 4807.9 4959.6 4989.5 5014.8 5246.2 18998.2 19076.7 19435.6 19492.4 19655.5 18567.7 18995.4 19470.9 19481.0 19519.7 10793.2 10898.1 10904.0 10974.9 10975.3 7426.1 7775.7 7827.4 7929.5 7935.2 16485.2 16637.4 16930.8 17014.3 17571.3 16905.7 17172.4 17259.0 17434.0 17592.2 11465.0 11525.0 11565.4 11715.9 11721.6 12999.2 13063.7 13146.5 13152.8 13158.6 10297.2 10380.3 10453.7 10489.8 10686.2 10252.4 10393.6 10429.6 10440.5 10609.5 9007.2 9043.7 9110.9 9141.3 9144.0 6857.1 7002.5 7024.2 7042.5 7085.9 6852.0 6939.7 6958.6 6994.0 7032.9 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | [#4] prototype.html Cycles:180 Average:5521.48 Median:6170.52 stddev:1568.29 (25.4%) stddev-sans-first:1526.14 03:56:41 INFO - PID 26703 | Values: 468.4 483.8 495.4 496.1 502.5 6209.4 6292.4 6309.3 6325.0 6344.0 5997.9 6195.2 6217.0 6221.6 6228.0 4898.5 4954.9 4968.7 4978.9 5002.3 4970.8 4971.6 4985.8 4993.9 5024.4 4773.6 4840.3 4883.0 4938.9 4952.5 4871.8 4877.1 4908.3 4970.5 4994.4 4402.4 4415.9 4424.2 4430.6 4442.6 6067.9 6090.1 6112.8 6125.5 6145.8 5706.6 5707.9 5744.7 5759.2 5773.3 6593.0 6601.5 6614.1 6626.8 6671.5 4820.5 4836.9 4848.9 4863.2 4888.6 6970.0 7044.2 7049.5 7085.4 7100.0 4951.9 4958.5 4979.3 4981.5 5061.9 5018.4 5023.9 5065.2 5077.9 5098.8 5716.3 5724.0 5737.5 5778.3 5782.4 6565.0 6645.3 6668.9 6696.5 6771.2 1667.5 1701.4 1718.8 1744.3 1755.8 1133.2 1156.6 1200.7 1210.2 1214.6 5742.0 5755.0 5783.8 5786.6 5828.4 6712.7 6733.5 6736.5 6760.7 6774.0 5662.8 5672.5 5776.9 5785.7 5844.0 3609.0 3612.8 3614.7 3632.5 3646.5 6481.7 6492.6 6556.2 6592.4 6623.8 6911.5 6979.2 7010.5 7016.5 7045.4 6465.6 6472.5 6545.9 6587.9 6629.7 6588.3 6693.7 6717.6 6741.7 6763.3 6688.5 6700.7 6718.7 6752.6 6804.1 6524.0 6535.4 6566.4 6571.9 6607.6 4950.4 4964.3 4976.6 4992.4 4997.3 6689.9 6748.0 6755.7 6759.0 6836.3 6480.7 6534.4 6542.3 6545.1 6596.2 6376.9 6434.6 6520.5 6551.9 6628.8 6226.6 6357.7 6415.5 6462.8 6479.7 6323.7 6392.9 6394.9 6503.8 6571.2 6213.5 6309.5 6335.7 6406.2 6418.7 03:56:41 INFO - PID 26703 | 03:56:41 INFO - PID 26703 | [#5] yui.html Cycles:180 Average:23618.16 Median:20379.95 stddev:31316.58 (153.7%) stddev-sans-first:31357.97 03:56:41 INFO - PID 26703 | Values: 901.0 918.8 934.8 939.8 942.2 18809.5 19800.4 19809.9 19814.7 19817.9 17714.1 17835.8 17868.4 22439.9 22444.9 1045.0 1067.4 1067.5 1068.4 1075.7 1069.0 1069.1 1072.5 1072.8 1073.8 1064.2 1103.6 1119.8 1127.8 1142.2 1102.2 1106.2 1107.4 1108.1 1108.2 796.8 801.7 804.7 805.6 808.2 20148.8 20329.0 20430.9 20506.5 20780.7 21271.1 21368.8 21618.8 22083.8 22091.9 16486.5 16646.8 16824.1 16938.1 17003.7 3584.9 3620.7 3630.4 3630.9 3644.8 127733.4 128640.0 131402.7 132915.3 133404.0 16830.0 17015.8 17116.9 17137.4 17450.5 31567.2 31793.8 32195.2 32361.7 32443.0 8566.2 8582.4 8619.7 8654.5 8673.0 4301.3 4433.2 4466.9 4478.2 4484.0 5112.4 5209.1 5221.2 5222.6 5700.6 1063.4 1075.2 1101.8 1102.0 1102.0 674.1 689.6 691.8 704.4 711.8 11774.7 12199.8 12408.6 12412.6 12902.5 676.9 687.1 688.7 692.3 692.6 5370.4 5373.2 5629.9 5771.5 5927.0 97421.0 98469.5 98895.0 99968.5 100294.5 90880.0 94005.5 95052.0 95363.5 95477.0 79083.2 81132.6 81186.6 84382.0 85909.0 10828.5 11093.5 12383.3 12591.4 12910.0 36156.3 37359.0 37436.0 38066.8 40159.4 69798.0 69928.0 70372.6 71198.0 75444.9 19693.0 19776.3 19787.8 19975.1 20090.1 20847.8 21532.8 21568.9 21851.7 21868.5 18367.1 18576.2 18715.3 18899.2 19311.1 18377.7 18652.4 18739.5 18810.5 18821.4 18570.4 19233.2 19321.6 19540.8 19551.3 13624.7 13635.3 13898.9 14057.9 14632.3 14215.6 14662.7 14928.8 15176.6 15433.6 03:56:41 INFO - PID 26703 | -------- Summary: end -------- 03:56:41 INFO - PID 26703 | 03:56:41 INFO - TEST-INFO | 26703: exit 0 03:56:41 INFO - TEST-OK | dromaeo_css | took 1113545ms 03:56:41 INFO - TEST-START | kraken 03:56:41 INFO - Initialising browser for kraken test... 03:56:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50110/getInfo.html -profile /tmp/tmpRYHjDk/profile 03:56:41 INFO - TEST-INFO | started process 27071 (/builds/slave/test/build/application/firefox/firefox http://localhost:50110/getInfo.html) 03:56:47 INFO - TEST-INFO | 27071: exit 0 03:56:47 INFO - Browser initialized. 03:56:47 INFO - Running cycle 1/1 for kraken test... 03:56:47 INFO - TEST-INFO | started process 27299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRYHjDk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:48 INFO - PID 27299 | 03:56:48 INFO - PID 27299 | (/builds/slave/test/build/application/firefox/firefox:27352): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:56:48 INFO - PID 27299 | 03:56:58 INFO - PID 27299 | RSS: Main: 174452736 03:56:58 INFO - PID 27299 | 03:57:01 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50110/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:02 INFO - PID 27299 | RSS: Main: 178552832 03:57:02 INFO - PID 27299 | 03:57:05 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50110/tests/kraken/driver.html?testName=audio-dft) 03:57:05 INFO - PID 27299 | RSS: Main: 179449856 03:57:05 INFO - PID 27299 | 03:57:09 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50110/tests/kraken/driver.html?testName=audio-fft) 03:57:09 INFO - PID 27299 | RSS: Main: 174317568 03:57:09 INFO - PID 27299 | 03:57:11 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50110/tests/kraken/driver.html?testName=audio-oscillator) 03:57:12 INFO - PID 27299 | RSS: Main: 174809088 03:57:12 INFO - PID 27299 | 03:57:14 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:15 INFO - PID 27299 | RSS: Main: 175312896 03:57:15 INFO - PID 27299 | 03:57:18 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50110/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:19 INFO - PID 27299 | RSS: Main: 177815552 03:57:19 INFO - PID 27299 | 03:57:22 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50110/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:23 INFO - PID 27299 | RSS: Main: 176574464 03:57:23 INFO - PID 27299 | 03:57:26 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50110/tests/kraken/driver.html?testName=json-parse-financial) 03:57:26 INFO - PID 27299 | RSS: Main: 177758208 03:57:26 INFO - PID 27299 | 03:57:28 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:29 INFO - PID 27299 | RSS: Main: 177422336 03:57:29 INFO - PID 27299 | 03:57:31 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:31 INFO - PID 27299 | RSS: Main: 175153152 03:57:31 INFO - PID 27299 | 03:57:33 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:34 INFO - PID 27299 | RSS: Main: 175161344 03:57:34 INFO - PID 27299 | 03:57:37 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:38 INFO - PID 27299 | RSS: Main: 175017984 03:57:38 INFO - PID 27299 | 03:57:41 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:41 INFO - PID 27299 | RSS: Main: 175194112 03:57:41 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | Cycle 1(1): loaded http://localhost:50110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50110/tests/kraken/driver.html?testName=ai-astar) 03:57:43 INFO - PID 27299 | RSS: Main: 176795648 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | __start_tp_report 03:57:43 INFO - PID 27299 | _x_x_mozilla_page_load 03:57:43 INFO - PID 27299 | _x_x_mozilla_page_load_details 03:57:43 INFO - PID 27299 | |i|pagename|runs| 03:57:43 INFO - PID 27299 | |0;ai-astar;104;111;102;108;108;110;107;97;110;110 03:57:43 INFO - PID 27299 | |1;audio-beat-detection;147;123;148;192;127;167;146;125;171;119 03:57:43 INFO - PID 27299 | |2;audio-dft;165;163;163;164;163;166;167;170;163;171 03:57:43 INFO - PID 27299 | |3;audio-fft;74;75;75;172;76;75;80;79;163;78 03:57:43 INFO - PID 27299 | |4;audio-oscillator;80;88;141;79;78;82;140;83;79;127 03:57:43 INFO - PID 27299 | |5;imaging-gaussian-blur;114;116;114;113;114;114;118;122;117;116 03:57:43 INFO - PID 27299 | |6;imaging-darkroom;152;151;155;154;151;152;150;150;150;149 03:57:43 INFO - PID 27299 | |7;imaging-desaturate;100;94;94;94;100;99;94;94;95;94 03:57:43 INFO - PID 27299 | |8;json-parse-financial;55;55;59;63;55;55;56;56;56;56 03:57:43 INFO - PID 27299 | |9;json-stringify-tinderbox;56;54;57;53;54;60;53;55;54;55 03:57:43 INFO - PID 27299 | |10;stanford-crypto-aes;78;79;80;80;78;79;81;89;78;79 03:57:43 INFO - PID 27299 | |11;stanford-crypto-ccm;137;139;128;141;127;128;131;126;129;167 03:57:43 INFO - PID 27299 | |12;stanford-crypto-pbkdf2;172;172;179;174;178;178;177;184;172;174 03:57:43 INFO - PID 27299 | |13;stanford-crypto-sha256-iterative;69;69;66;65;65;65;68;70;72;73 03:57:43 INFO - PID 27299 | __end_tp_report 03:57:43 INFO - PID 27299 | __start_cc_report 03:57:43 INFO - PID 27299 | _x_x_mozilla_cycle_collect,951 03:57:43 INFO - PID 27299 | __end_cc_report 03:57:43 INFO - PID 27299 | __startTimestamp1501930663956__endTimestamp 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | ------- Summary: start ------- 03:57:43 INFO - PID 27299 | Number of tests: 14 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#0] ai-astar Cycles:10 Average:106.70 Median:110.00 stddev:4.45 (4.0%) stddev-sans-first:4.61 03:57:43 INFO - PID 27299 | Values: 104.0 111.0 102.0 108.0 108.0 110.0 107.0 97.0 110.0 110.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:147.50 stddev:24.14 (16.4%) stddev-sans-first:25.60 03:57:43 INFO - PID 27299 | Values: 147.0 123.0 148.0 192.0 127.0 167.0 146.0 125.0 171.0 119.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:2.99 (1.8%) stddev-sans-first:3.17 03:57:43 INFO - PID 27299 | Values: 165.0 163.0 163.0 164.0 163.0 166.0 167.0 170.0 163.0 171.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.50 stddev:38.48 (51.0%) stddev-sans-first:40.07 03:57:43 INFO - PID 27299 | Values: 74.0 75.0 75.0 172.0 76.0 75.0 80.0 79.0 163.0 78.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:79.50 stddev:26.83 (33.8%) stddev-sans-first:27.69 03:57:43 INFO - PID 27299 | Values: 80.0 88.0 141.0 79.0 78.0 82.0 140.0 83.0 79.0 127.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.00 stddev:2.70 (2.3%) stddev-sans-first:2.78 03:57:43 INFO - PID 27299 | Values: 114.0 116.0 114.0 113.0 114.0 114.0 118.0 122.0 117.0 116.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.50 stddev:1.90 (1.3%) stddev-sans-first:2.00 03:57:43 INFO - PID 27299 | Values: 152.0 151.0 155.0 154.0 151.0 152.0 150.0 150.0 150.0 149.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:94.00 stddev:2.70 (2.9%) stddev-sans-first:2.40 03:57:43 INFO - PID 27299 | Values: 100.0 94.0 94.0 94.0 100.0 99.0 94.0 94.0 95.0 94.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.55 (4.5%) stddev-sans-first:2.64 03:57:43 INFO - PID 27299 | Values: 55.0 55.0 59.0 63.0 55.0 55.0 56.0 56.0 56.0 56.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:2.13 (3.9%) stddev-sans-first:2.24 03:57:43 INFO - PID 27299 | Values: 56.0 54.0 57.0 53.0 54.0 60.0 53.0 55.0 54.0 55.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:3.28 (4.1%) stddev-sans-first:3.39 03:57:43 INFO - PID 27299 | Values: 78.0 79.0 80.0 80.0 78.0 79.0 81.0 89.0 78.0 79.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:134.00 stddev:12.36 (9.2%) stddev-sans-first:13.09 03:57:43 INFO - PID 27299 | Values: 137.0 139.0 128.0 141.0 127.0 128.0 131.0 126.0 129.0 167.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:177.50 stddev:3.92 (2.2%) stddev-sans-first:3.88 03:57:43 INFO - PID 27299 | Values: 172.0 172.0 179.0 174.0 178.0 178.0 177.0 184.0 172.0 174.0 03:57:43 INFO - PID 27299 | 03:57:43 INFO - PID 27299 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:2.94 (4.3%) stddev-sans-first:3.10 03:57:43 INFO - PID 27299 | Values: 69.0 69.0 66.0 65.0 65.0 65.0 68.0 70.0 72.0 73.0 03:57:43 INFO - PID 27299 | -------- Summary: end -------- 03:57:43 INFO - PID 27299 | 03:57:44 INFO - PID 27299 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:57:44 INFO - TEST-INFO | 27299: exit 0 03:57:44 INFO - TEST-OK | kraken | took 62888ms 03:57:44 INFO - SUITE-END | took 1176s 03:57:45 INFO - Completed test suite (00:19:36) 03:57:45 INFO - javascript benchmark 03:57:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8565.046700352214, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.8111913285206, 3151.558781770551, 3175.888843890464, 3210.983945080274, 3217.067050555339, 6150.169727086842, 6191.721372538235, 6213.844653883655, 6217.689115544227, 6229.813105606839, 6250.374962503747, 6250.406211409909, 6262.248530176374, 6280.623162610246, 6287.497000239981, 5731.541476681877, 5732.398098199692, 5744.253247077874, 5793.275840519935, 5802.042662960606, 5729.455701708331, 5729.914051289234, 5753.884922301551, 5771.855703607402, 5815.447532484428, 5827.67947762875, 5837.503812175949, 5844.357120716739, 5888.499477544414, 5889.411058894119, 5812.738426770806, 5892.793752218695, 5892.88214235715, 5908.822735317947, 5912.320083190445, 5587.106063029936, 5732.484076433099, 5816.680082595455, 5826.329972053226, 5829.446202610745, 6043.365446628085, 6077.513798896122, 6147.139400483936, 6164.722587483574, 6208.844778880519, 6700.061991321219, 6758.087658166134, 6773.4242589379965, 6781.932180678179, 6813.727450901958, 6791.490638202105, 6813.318668133147, 6856.691448884762, 6899.068625735512, 6913.2049814270995, 6165.784197553064, 6278.6546739929745, 6303.7163327649905, 6368.840778980516, 6368.904466432961, 6890.896636550456, 6892.207396149507, 6912.412444942236, 6918.204406493318, 6918.377346038881, 6500.902486462707, 6519.282878883319, 6575.473962083118, 6577.440917521969, 6578.375054369827, 6362.681865906686, 6648.767293144717, 6743.393094621508, 6772.932270677329, 6821.045053692487, 6672.132622759011, 6672.299408562031, 6744.62904540255, 6810.114685090906, 6811.944148656966, 6636.634985075771, 6707.49693772969, 6716.865662686719, 6735.831604209934, 6815.0, 5419.945800542023, 5433.0763770159165, 5454.809081682122, 5507.669539827623, 5526.944730552643, 4677.134730074947, 4691.061787642485, 4725.9527404726205, 4746.359241502422, 4747.240441529339, 5767.567432442584, 5848.678322692293, 5852.882942341214, 5853.560982926298, 5863.853403664943, 6689.565178263495, 6695.464362851058, 6700.798976030727, 6768.763093291711, 6774.288699686561, 5744.540436765049, 5765.798197063083, 5776.884462310731, 5811.27359080115, 5825.941740582624, 5950.2264705587995, 5950.285965684059, 5954.940450595525, 5960.4635582797755, 5964.821055368259, 6471.546991710535, 6525.314841941623, 6557.803265902031, 6558.672066396661, 6563.868722625521, 6750.729970801113, 6773.322667733188, 6773.525853190229, 6776.254611992776, 6936.167659880846, 6542.149520562297, 6543.345665433419, 6559.573627714183, 6627.966860165669, 6655.301193374626, 6526.314736952551, 6618.669066546557, 6654.035164901159, 6676.56602320867, 6765.357291057342, 6764.830879227862, 6883.174019117738, 6884.173899131936, 6887.414569761627, 6898.931010689829, 6548.1814773153355, 6591.176102987127, 6636.933630663631, 6637.734490620321, 6641.0, 6546.69066186774, 6575.178102737158, 6644.501662375244, 6644.867102658017, 6658.300878407697, 6360.522960777867, 6444.13004244421, 6470.255920569007, 6474.546781725422, 6604.702788374439, 6519.217693876765, 6612.437942774918, 6623.966880165761, 6624.6025238485845, 6628.072069910313, 6310.810675679737, 6363.872722545616, 6390.0, 6402.35976402356, 6414.294427612866], "value": 6154.667313225924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.7143571160815, 818.9590520473977, 826.7685048186509, 1159.5767544846128, 1186.3534373766308, 30817.0, 42822.0, 43358.34962475562, 43589.78205108978, 43592.564074359245, 43977.78011109948, 44129.0, 44452.777736111355, 44508.77745611275, 44510.0, 7750.961245193766, 7945.404094692893, 7945.9602701986405, 7952.085510166318, 7953.4432589718745, 7742.109657389387, 7821.217878212162, 7869.095054068798, 7889.171636978121, 7903.012123484565, 7891.8421631567335, 7921.04947406312, 7928.484648497858, 7969.9203007970045, 7979.960100199491, 7815.452918295721, 7839.568823714693, 7853.175416581291, 7882.724104656367, 7933.920660793405, 7707.190744971754, 7741.8451630967065, 7759.612019399064, 7779.37764978806, 7780.649870755829, 39153.80423097866, 39370.21259574821, 39383.40924886129, 39403.21193576112, 39414.40878386827, 3637.854485820564, 3669.7798132111893, 3669.889903302905, 3672.9081772955624, 3678.0, 30820.537691934638, 31010.0, 31112.377752444823, 31209.375812483624, 31244.375112497622, 4890.73100979446, 4950.851474455772, 4961.18140506816, 4984.352034235526, 4994.150994330972, 185974.0, 186234.0, 186587.0, 186750.0, 188423.99999999863, 49263.261051084264, 49503.50496494989, 49657.255141172915, 49939.75030124826, 49947.0, 50960.74519627378, 51473.48526514762, 51492.48507514952, 51507.0, 51649.48350516447, 14166.929165354313, 14214.360353784105, 16453.0, 16644.83355166457, 16909.0, 13800.585982420343, 13951.441942322397, 13953.372098255602, 13959.092658977133, 13959.371828267753, 14534.85465145335, 14542.491012814713, 14574.19841908684, 14720.190389528465, 14880.181590012437, 5787.88424231513, 5909.704514774244, 5925.674087925119, 6007.36922623127, 6020.187274717945, 983.6360546597662, 1005.2360206243162, 1008.5159123620704, 1011.716719318592, 1033.9896601033893, 23197.0, 29082.56376154317, 29263.122106336843, 29373.559396609067, 29760.55359169614, 1069.5828626835541, 1083.0956151613334, 1084.766775143348, 1102.5644870276196, 1111.8943700348455, 12042.15704900666, 12285.815712764315, 12330.753384932252, 12382.504699811907, 12392.62822115338, 235469.0, 240721.0, 240772.0, 242136.0, 242630.0, 52608.47391526036, 53105.0, 53299.733501332244, 53433.198502022504, 53470.0, 1452.6532603393246, 1460.4523303761089, 1467.8678918897351, 1476.60131764423, 1478.1426772471941, 22413.887930560242, 22432.32703018912, 22490.437739056, 22553.88723056374, 22723.431914201617, 36177.819110904275, 36373.27253454863, 36381.818090910434, 36456.27087458183, 36457.63542364648, 201971.0, 202190.0, 202492.0, 202921.0, 202923.0, 33229.16927076843, 36925.44611830771, 38796.6120338793, 38910.4163437543, 39056.80471597738, 45742.08515829731, 47920.28119578279, 47975.76012119917, 48388.5161148384, 48787.26819097645, 34188.31623367469, 34434.0, 34478.65521344855, 34546.48180277348, 35347.82326088353, 33811.83094084514, 34031.0, 34148.31703365869, 34905.47641785324, 35020.29959400747, 37951.62048379481, 38102.428463573626, 38358.42462363011, 38456.423153652155, 38469.42295865508, 33403.83298083494, 33648.663513364554, 33762.49356259707, 34080.0, 34385.31229375448, 24199.395015124763, 24408.26775196747, 24574.262772116865, 24704.382390440383, 24802.50394992126], "value": 17692.4749495401, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.4357875386514, 603.7343568829712, 605.5851741557034, 611.5077362723009, 621.4282859769013, 22402.215922442698, 22825.201117960874, 23010.88494557529, 23014.88492557535, 23021.0, 21489.785102148973, 21511.139554417805, 22572.209972650962, 27369.45261094777, 27661.86169069157, 6372.394622510866, 6518.641474718888, 6539.476841852664, 6539.836504087389, 6548.967255163718, 5912.467877890989, 6407.551471397004, 6454.612723236621, 6455.806325810233, 6489.286178520359, 6436.420722135007, 6460.321666225049, 6461.709223084949, 6464.353564643545, 6465.967670161643, 6430.517711171634, 6438.452731517803, 6444.097826304321, 6448.774292899773, 6449.516286278525, 5862.589618726691, 5899.351071382144, 5934.902043122036, 5937.584369094165, 5970.313413957407, 29078.41843163146, 29210.41579168405, 29766.404671906657, 29800.552991705143, 30807.075787726404, 1907.3324336482258, 1942.0483962858239, 1956.8141026602593, 1965.7149713291635, 1978.0900785638623, 19540.609187816164, 19633.410997670093, 20020.29928952494, 20185.293514726913, 20643.483912902146, 2433.513297340539, 2438.829281950264, 2477.814163937712, 2490.2280293109193, 2500.5124000819847, 117692.0, 122755.38622306832, 135269.0, 141073.29463352618, 144544.0, 14556.297426346668, 15268.694626107415, 15551.533453996399, 15666.921665391601, 15717.921410393104, 21451.356459305935, 21457.892710536347, 21491.462713431978, 21494.57010859774, 21627.35117946464, 10261.794764104676, 10309.381437113798, 10389.480525973671, 10484.056434920894, 10528.36829790215, 9722.173615242642, 9759.316847820726, 9820.361676491148, 9871.358361706467, 9999.700008999742, 9182.265418766483, 9238.214751746176, 9441.386309889835, 9476.194523465583, 9522.761930951781, 2689.0, 2700.4464084862557, 2755.917322480329, 2772.4039331543413, 2888.176869592156, 954.5513608603945, 992.3400938376044, 997.3417544420647, 999.7000899730052, 1001.234055947201, 19652.901735491232, 19844.801551984583, 19989.737611653418, 20186.09162587687, 20361.490962725755, 1052.7947050325267, 1065.8880817514205, 1067.80779459698, 1068.791585640808, 1079.7894410590018, 10945.845345217864, 11140.721481963015, 11218.495167717472, 11232.10143188543, 11279.548818047351, 466200.0, 466308.0, 471301.0, 474545.0, 480890.0, 113151.0, 122214.38892805479, 122510.0, 122746.38626806988, 122748.0, 1214.4717048084112, 1217.933013684256, 1247.6756043428593, 1253.2981530343036, 1255.1276862580419, 17484.737728933822, 17727.91136044363, 17849.910750446164, 17866.91066544659, 17978.460646180636, 53394.19908701295, 54693.72653136709, 55727.0, 56000.719996399755, 57842.13236801367, 75956.0, 78032.0, 78541.0, 78958.6052069736, 79250.60374698321, 14729.968902176744, 14991.250437477864, 15618.9219053904, 15634.45279415215, 15663.608409789846, 23967.760322396553, 24294.514109717355, 24372.26883193507, 24391.756082439657, 24415.877920610284, 18834.905825470785, 19126.617467650292, 19225.13486893121, 19292.0, 19383.127759250587, 15822.446214382442, 16707.749383759012, 17015.7447638288, 17571.209295581986, 17591.296348146443, 19061.52346191301, 19302.613947720685, 19611.607767844278, 19611.901940490206, 19682.409527714193, 14523.564293071226, 15278.694426111193, 15377.538673839803, 15383.230838458256, 15421.383144674088, 18132.909335453238, 18289.085545722395, 18731.0, 18830.152643131365, 18857.24571017199], "value": 12103.238050988073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.6960933789899, 1352.9526466573673, 1399.6221020324513, 1401.824771903512, 1404.1996062244511, 13403.396847141878, 13907.860921390795, 13966.162030278165, 13971.231582262972, 13978.09142405743, 13913.58259252224, 14340.641483962907, 14361.425542978295, 14385.352659130338, 14386.712265754679, 2711.227300219443, 2750.724927507243, 2752.7384898434616, 2754.820936639112, 2754.9173524794287, 2634.3150780797037, 2831.504486714827, 2831.5469524876025, 2834.63149790528, 2837.645294338208, 2703.3106557827728, 2710.11921125634, 2717.877695503707, 2748.395353022332, 2750.642416485854, 2597.948041039169, 2613.908513202038, 2629.32952097214, 2634.657494525709, 2665.9466810663776, 2556.322574517754, 2603.2320465462735, 2636.868156592163, 2665.7200993895553, 2669.2125822882103, 13472.326383680776, 13799.517016904461, 13809.378577964017, 13848.86151138496, 13889.79165312521, 7315.561066335984, 7548.396128309722, 7549.660265288076, 7565.43259255558, 7583.165851756303, 5003.924941125886, 5140.588752899759, 5238.188080847474, 5284.656497327662, 5351.411344752074, 1828.2047309420445, 1833.2941817400263, 1872.7659042619673, 1882.8681992260547, 1912.2351059576142, 21110.89444552783, 23192.072317107297, 23412.64881026786, 23444.882775586182, 23460.882695586584, 6359.777407790705, 6447.2263328400895, 6664.200295964419, 6715.127033485714, 6717.361850624281, 15087.094774313577, 15104.320305586274, 15110.093394396372, 15148.772768408482, 15990.680186396206, 7544.396448284124, 7779.260970207822, 7786.1435242123325, 7794.0, 7814.648340824677, 7179.389751871149, 7189.173245076779, 7202.53183543068, 7252.093488313961, 7264.382527485117, 4821.5178482152205, 4974.577160941288, 5010.574101201366, 5027.145385284511, 5058.544730974157, 1417.666848290651, 1420.1195258939524, 1444.50886698523, 1444.9638759030897, 1455.4251070826965, 876.6186708781573, 907.5552979040223, 911.6900253913701, 919.1176470588176, 920.5949382271779, 6961.303869612998, 7060.5410648308725, 7101.147862256562, 7126.180489243803, 7146.892796608055, 976.6874600128033, 1000.3597697473623, 1005.7133716890651, 1012.767063575367, 1014.4927536231884, 4807.855764327076, 4959.62802789785, 4989.525995030466, 5014.774335154927, 5246.23929530216, 18998.24007039703, 19076.71384929227, 19435.611287774165, 19492.41522754291, 19655.508612284808, 18567.72148417775, 18995.43013709591, 19470.902645486683, 19481.0, 19519.707204391947, 10793.244472886823, 10898.12814974816, 10904.0, 10974.890251097388, 10975.28660637056, 7426.108866936002, 7775.727849525239, 7827.373810095065, 7929.5242285463055, 7935.246151615587, 16485.17574121313, 16637.41769038078, 16930.83069169342, 17014.31942722327, 17571.297148113932, 16905.66188676195, 17172.398966036628, 17259.0, 17434.0, 17592.208350623998, 11465.0, 11525.020373268366, 11565.363904985306, 11715.941420292844, 11721.589744358907, 12999.1550549214, 13063.673408164872, 13146.474141034634, 13152.802707959198, 13158.60524184276, 10297.17622590176, 10380.32527885685, 10453.738656533344, 10489.790204196026, 10686.198535110054, 10252.38485690861, 10393.58425662965, 10429.634962776267, 10440.530176142243, 10609.522571484147, 9007.189352958265, 9043.728688139367, 9110.90889091127, 9141.26869850397, 9144.0, 6857.108575885103, 7002.509824312249, 7024.227334993045, 7042.507024508235, 7085.858282834211, 6852.040714300102, 6939.653017349214, 6958.617276049866, 6994.0, 7032.894506582507], "value": 6350.5576581834885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.4495717531899, 483.83791429871, 495.38819557846034, 496.0995792636365, 502.4874627879563, 6209.441150296478, 6292.413324405091, 6309.3059763426045, 6325.0, 6343.968280158604, 5997.940020599804, 6195.2255968004, 6216.968915155418, 6221.595596286238, 6228.003519436891, 4898.461169271377, 4954.925676114861, 4968.701877887338, 4978.850634480971, 5002.349694539705, 4970.751462426882, 4971.627127965399, 4985.825496107637, 4993.850184494471, 5024.371953505812, 4773.64197685175, 4840.346553215324, 4883.0, 4938.851834444972, 4952.479989601094, 4871.780769865347, 4877.122118018738, 4908.263760435963, 4970.539582906485, 4994.35073440454, 4402.3836662867225, 4415.933760993587, 4424.159409712177, 4430.579094985971, 4442.577955094261, 6067.908981365283, 6090.147379366892, 6112.821332906908, 6125.509959203253, 6145.815625531197, 5706.600537962344, 5707.942920570824, 5744.741486633112, 5759.164921086419, 5773.3442616396505, 6593.0, 6601.471882249409, 6614.140161778986, 6626.801195964129, 6671.466282697373, 4820.493848145929, 4836.879078023042, 4848.927266091011, 4863.19757240055, 4888.584470320027, 6970.0, 7044.189918159374, 7049.519600883769, 7085.433165346812, 7099.964500177518, 4951.870695600855, 4958.454569997298, 4979.278004689299, 4981.526754958273, 5061.898762024739, 5018.42288136869, 5023.899522009612, 5065.240213967934, 5077.923831142536, 5098.770555325019, 5716.28546431696, 5723.971380143156, 5737.540996720252, 5778.3354914184565, 5782.421757824184, 6564.9671751640935, 6645.335466453413, 6668.899966500507, 6696.497762667819, 6771.153605799275, 1667.4914151184005, 1701.4470297153475, 1718.8453039226529, 1744.3284335530911, 1755.824417558234, 1133.1784456269138, 1156.5951916829042, 1200.699825043739, 1210.2194084815244, 1214.6173955204083, 5742.0, 5755.0, 5783.826485205451, 5786.594938354359, 5828.358880523139, 6712.664366781642, 6733.528652994243, 6736.46108311334, 6760.7295708172105, 6773.966130169318, 5662.801801936995, 5672.489475947102, 5776.884462310731, 5785.652860828363, 5843.970780146157, 3608.9819550902075, 3612.83876607968, 3614.710823134143, 3632.4551317302617, 3646.4894914711963, 6481.740730370827, 6492.610443373318, 6556.24603170632, 6592.351912021994, 6623.801285961429, 6911.481638877104, 6979.232284448706, 7010.509264351446, 7016.456379596582, 7045.401140903081, 6465.579737317154, 6472.5145614080075, 6545.9018114728315, 6587.934120658828, 6629.668516574248, 6588.308227636221, 6693.690676716525, 6717.56335838169, 6741.696623652046, 6763.256041835492, 6688.498362622726, 6700.731970721312, 6718.7312507499155, 6752.628605426552, 6804.081449004321, 6523.967380163259, 6535.411812936859, 6566.376194261537, 6571.901421478778, 6607.603543787388, 4950.356453661001, 4964.329815475009, 4976.576990955809, 4992.425871024879, 4997.250412438163, 6689.896167132563, 6748.0, 6755.662216889037, 6759.0, 6836.282190370139, 6480.740770369132, 6534.379233972765, 6542.34576542342, 6545.14913061299, 6596.175478065242, 6376.904346434714, 6434.646094464662, 6520.478361731145, 6551.934480655133, 6628.801135965929, 6226.62640241587, 6357.7139028742895, 6415.524429381175, 6462.773802917063, 6479.708413121327, 6323.652199129092, 6392.9360706392345, 6394.87210255783, 6503.756204109574, 6571.178602674666, 6213.506885304777, 6309.463695585927, 6335.67377127012, 6406.23125224976, 6418.679066046586], "value": 5050.855231136808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [900.9774755631113, 918.8208299381619, 934.8083642853215, 939.7556635274831, 942.1567696911264, 18809.529761755963, 19800.40598782035, 19809.900950495263, 19814.70277945832, 19817.900910495464, 17714.1142942853, 17835.82164178358, 17868.374606888763, 22439.887800560973, 22444.8877755611, 1044.9895501044987, 1067.3649178738676, 1067.5409573883228, 1068.4444089073677, 1075.6772968109574, 1069.0485467933545, 1069.0752499088271, 1072.4798472740715, 1072.7961687279392, 1073.7798751256014, 1064.2337516987757, 1103.624767579023, 1119.7648493816268, 1127.836463712761, 1142.2175809570472, 1102.2339474065527, 1106.1593189176244, 1107.3909349857627, 1108.146727020194, 1108.2297803026859, 796.8406318736276, 801.6673080671515, 804.7223707820792, 805.613305613303, 808.1635507250027, 20148.798512014986, 20329.0, 20430.897845510677, 20506.487337816525, 20780.688289675665, 21271.14915403382, 21368.786312136992, 21618.783812161833, 22083.779162208495, 22091.889540552354, 16486.505404837873, 16646.833531664648, 16824.07467589282, 16938.068406237653, 17003.65992680152, 3584.8566057357675, 3620.7103431725664, 3630.3828349180703, 3630.9273814523826, 3644.763090399142, 127733.36133319366, 128640.0, 131402.68597314096, 132915.33542332228, 133404.0, 16830.0, 17015.82984170167, 17116.91441542809, 17137.400190993256, 17450.47648570545, 31567.21081972969, 31793.84103079516, 32195.195120122185, 32361.676383235867, 32443.0, 8566.229039386486, 8582.399232053696, 8619.655213791504, 8654.524001179996, 8672.95663521691, 4301.333293339538, 4433.179861725591, 4466.888327791831, 4478.193925093449, 4483.977580112144, 5112.386513618315, 5209.140491818807, 5221.190715439113, 5222.608304377187, 5700.629459085146, 1063.3619828103076, 1075.2258373970728, 1101.8126918423886, 1101.9669409917556, 1101.983470247947, 674.0832467843728, 689.6000319814495, 691.8062942376142, 704.4188544450849, 711.8184862859938, 11774.705632359259, 12199.817002744965, 12408.56570020045, 12412.62762117138, 12902.548410805577, 676.8781619308473, 687.0793137196181, 688.7382794538044, 692.3042342445809, 692.5775277080977, 5370.4361042090795, 5373.247745315659, 5629.944009404878, 5771.538276937835, 5927.022041363127, 97421.0, 98469.50765246128, 98895.0, 99968.50015749874, 100294.49852750689, 90880.0, 94005.5299723497, 95052.0, 95363.52318238503, 95477.0, 79083.20916790873, 81132.59433702912, 81186.59406702929, 84382.0, 85909.0, 10828.458577071273, 11093.500792464198, 12383.257004579755, 12591.433385497492, 12910.0, 36156.27687446184, 37359.0, 37436.0, 38066.80966595149, 40159.3976090353, 69797.95303070356, 69928.0, 70372.64813676104, 71198.0, 75444.86832697624, 19693.0, 19776.30782922591, 19787.802121978595, 19975.101120449322, 20090.095945682187, 20847.791522084586, 21532.784672153706, 21568.89215553912, 21851.672224916958, 21868.45328866791, 18367.14289999115, 18576.164072617034, 18715.344962926232, 18899.244030238635, 19311.130999104793, 18377.72433413473, 18652.44042678722, 18739.531511712317, 18810.52973675669, 18821.435356939313, 18570.44288671342, 19233.230670773013, 19321.613567728848, 19540.804591954467, 19551.315703950295, 13624.65938351549, 13635.250061246727, 13898.861011390161, 14057.859421405656, 14632.34154463073, 14215.573532794033, 14662.706745865236, 14928.7760683592, 15176.620584485476, 15433.614159646098], "value": 9338.545733920753, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 102.0, 108.0, 108.0, 110.0, 107.0, 97.0, 110.0, 110.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 148.0, 192.0, 127.0, 167.0, 146.0, 125.0, 171.0, 119.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 164.0, 163.0, 166.0, 167.0, 170.0, 163.0, 171.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 172.0, 76.0, 75.0, 80.0, 79.0, 163.0, 78.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 141.0, 79.0, 78.0, 82.0, 140.0, 83.0, 79.0, 127.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 113.0, 114.0, 114.0, 118.0, 122.0, 117.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 155.0, 154.0, 151.0, 152.0, 150.0, 150.0, 150.0, 149.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 94.0, 94.0, 100.0, 99.0, 94.0, 94.0, 95.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 59.0, 63.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 53.0, 54.0, 60.0, 53.0, 55.0, 54.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 80.0, 78.0, 79.0, 81.0, 89.0, 78.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 128.0, 141.0, 127.0, 128.0, 131.0, 126.0, 129.0, 167.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 179.0, 174.0, 178.0, 178.0, 177.0, 184.0, 172.0, 174.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 66.0, 65.0, 65.0, 65.0, 68.0, 70.0, 72.0, 73.0], "value": 68.2, "unit": "score"}]}]} 03:57:45 INFO - Return code: 0 03:57:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:45 INFO - # TBPL SUCCESS # 03:57:45 INFO - Running post-action listener: _package_coverage_data 03:57:45 INFO - Running post-action listener: _resource_record_post_action 03:57:45 INFO - [mozharness: 2017-08-05 10:57:45.211811Z] Finished run-tests step (success) 03:57:45 INFO - Running post-run listener: _resource_record_post_run 03:57:45 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436314112; Read time: 16; Write time: 338168 03:57:45 INFO - TinderboxPrint: CPU usage
13.2% 03:57:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:57:45 INFO - TinderboxPrint: I/O write bytes / time
436,314,112 / 338,168 03:57:45 INFO - TinderboxPrint: CPU idle
8,269.6 (86.8%) 03:57:45 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 03:57:45 INFO - TinderboxPrint: Swap in / out
0 / 0 03:57:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112513024; Read time: 0; Write time: 130076 03:57:45 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:45 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 323801088; Read time: 0; Write time: 208092 03:57:45 INFO - Running post-run listener: _upload_blobber_files 03:57:45 INFO - Blob upload gear active. 03:57:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:45 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:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:57:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:47 INFO - (blobuploader) - INFO - Done attempting. 03:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:47 INFO - (blobuploader) - INFO - Done attempting. 03:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:48 INFO - (blobuploader) - INFO - Done attempting. 03:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:55 INFO - (blobuploader) - INFO - Done attempting. 03:57:55 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:55 INFO - Return code: 0 03:57:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3b6cd871722b47665ddaa56646a6ab944c5e24aef8b8595b5a43faadd068a497bc25e64a951dfd549ed9063b855f06a7520ec060662cdd13da4089f365ecca4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54703206ed858b303311e6de92788b65c08cb931a2373a91e5cfddc2cc52fefdf1d67bb664abf47510d57f904f4b8dab9b39ad77dca3799b8045e812f546daa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e4b2886c5ec00212c87f7d22034e504b9faf065b485dc695cdfe87157385e3cad3d29c03dd9157f1c0408a30b34b9bf39363221d23eb3e6b6ca3417f613e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d11d5fd585698154e120423314f0a089a3df6e4cafadf699810c310691720432dc3836aee8f86754b9925cf393f94a15f9a9e5ff641bd68583dacde18c9b588"} 03:57:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:55 INFO - Contents: 03:57:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3b6cd871722b47665ddaa56646a6ab944c5e24aef8b8595b5a43faadd068a497bc25e64a951dfd549ed9063b855f06a7520ec060662cdd13da4089f365ecca4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54703206ed858b303311e6de92788b65c08cb931a2373a91e5cfddc2cc52fefdf1d67bb664abf47510d57f904f4b8dab9b39ad77dca3799b8045e812f546daa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e4b2886c5ec00212c87f7d22034e504b9faf065b485dc695cdfe87157385e3cad3d29c03dd9157f1c0408a30b34b9bf39363221d23eb3e6b6ca3417f613e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d11d5fd585698154e120423314f0a089a3df6e4cafadf699810c310691720432dc3836aee8f86754b9925cf393f94a15f9a9e5ff641bd68583dacde18c9b588"} 03:57:55 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:55 INFO - Copying logs to upload dir... 03:57:55 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.763207 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-05 03:57:54.348083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:54.351744) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296 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/sha512/f3b6cd871722b47665ddaa56646a6ab944c5e24aef8b8595b5a43faadd068a497bc25e64a951dfd549ed9063b855f06a7520ec060662cdd13da4089f365ecca4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54703206ed858b303311e6de92788b65c08cb931a2373a91e5cfddc2cc52fefdf1d67bb664abf47510d57f904f4b8dab9b39ad77dca3799b8045e812f546daa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e4b2886c5ec00212c87f7d22034e504b9faf065b485dc695cdfe87157385e3cad3d29c03dd9157f1c0408a30b34b9bf39363221d23eb3e6b6ca3417f613e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d11d5fd585698154e120423314f0a089a3df6e4cafadf699810c310691720432dc3836aee8f86754b9925cf393f94a15f9a9e5ff641bd68583dacde18c9b588"} build_url:https://queue.taskcluster.net/v1/task/KWzyzWIlQJ2iudAWGgv8fQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 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/sha512/f3b6cd871722b47665ddaa56646a6ab944c5e24aef8b8595b5a43faadd068a497bc25e64a951dfd549ed9063b855f06a7520ec060662cdd13da4089f365ecca4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54703206ed858b303311e6de92788b65c08cb931a2373a91e5cfddc2cc52fefdf1d67bb664abf47510d57f904f4b8dab9b39ad77dca3799b8045e812f546daa4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e4b2886c5ec00212c87f7d22034e504b9faf065b485dc695cdfe87157385e3cad3d29c03dd9157f1c0408a30b34b9bf39363221d23eb3e6b6ca3417f613e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d11d5fd585698154e120423314f0a089a3df6e4cafadf699810c310691720432dc3836aee8f86754b9925cf393f94a15f9a9e5ff641bd68583dacde18c9b588"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:54.376172) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:54.376480) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1501929380.40838-991942296 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:57:54.459119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 03:57:54.459421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 03:57:54.459705) ========= ========= Total master_lag: 0.18 =========