builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1502013082.67 results: success (0) revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:22.666685) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:22.667075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:22.667354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:22.728664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:22.728948) ========= 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=eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 02:51:22-- 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% 225M=0s 2017-08-06 02:51:23 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212315 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:23.002295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:23.002568) ========= 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=eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.102889 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:23.120368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:23.120696) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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 fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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=eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 02:51:23,310 truncating revision to first 12 chars 2017-08-06 02:51:23,310 Setting DEBUG logging. 2017-08-06 02:51:23,310 attempt 1/10 2017-08-06 02:51:23,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe6609d22dfd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 02:51:23,897 unpacking tar archive at: mozilla-central-fe6609d22dfd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:24.070144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:24.070435) ========= script_repo_revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:24.070770) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:24.071027) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:24.084450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-06 02:51:24.084711) ========= /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=eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:51:24 INFO - MultiFileLogger online at 20170806 02:51:24 in /builds/slave/test 02:51:24 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 02:51:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:24 INFO - {'append_to_log': False, 02:51:24 INFO - 'base_work_dir': '/builds/slave/test', 02:51:24 INFO - 'blob_upload_branch': 'Firefox', 02:51:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:24 INFO - 'branch': 'Firefox', 02:51:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:24 INFO - 'code_coverage': False, 02:51:24 INFO - 'config_files': ('talos/linux_config.py',), 02:51:24 INFO - 'default_actions': ('clobber', 02:51:24 INFO - 'read-buildbot-config', 02:51:24 INFO - 'download-and-extract', 02:51:24 INFO - 'populate-webroot', 02:51:24 INFO - 'create-virtualenv', 02:51:24 INFO - 'install', 02:51:24 INFO - 'setup-mitmproxy', 02:51:24 INFO - 'run-tests'), 02:51:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:24 INFO - 'disable_ccov_upload': False, 02:51:24 INFO - 'download_minidump_stackwalk': True, 02:51:24 INFO - 'download_symbols': 'ondemand', 02:51:24 INFO - 'enable_stylo': False, 02:51:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:24 INFO - 'gecko_profile': False, 02:51:24 INFO - 'gecko_profile_interval': 0, 02:51:24 INFO - 'installer_path': 'installer.exe', 02:51:24 INFO - 'log_level': 'info', 02:51:24 INFO - 'log_name': 'talos', 02:51:24 INFO - 'log_to_console': True, 02:51:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:51:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:51:24 INFO - 'opt_config_files': (), 02:51:24 INFO - 'pip_index': False, 02:51:24 INFO - 'suite': 'dromaeojs-e10s', 02:51:24 INFO - 'system_bits': '32', 02:51:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:24 INFO - 'title': 'talos-linux64-ix-010', 02:51:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:24 INFO - 'use_talos_json': True, 02:51:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:24 INFO - 'work_dir': 'build'} 02:51:24 INFO - [mozharness: 2017-08-06 09:51:24.488206Z] Running clobber step. 02:51:24 INFO - Running pre-action listener: _resource_record_pre_action 02:51:24 INFO - Running main action method: clobber 02:51:24 INFO - rmtree: /builds/slave/test/build 02:51:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:31 INFO - Running post-action listener: _resource_record_post_action 02:51:31 INFO - [mozharness: 2017-08-06 09:51:31.593279Z] Finished clobber step (success) 02:51:31 INFO - [mozharness: 2017-08-06 09:51:31.593408Z] Running read-buildbot-config step. 02:51:31 INFO - Running pre-action listener: _resource_record_pre_action 02:51:31 INFO - Running main action method: read_buildbot_config 02:51:31 INFO - Using buildbot properties: 02:51:31 INFO - { 02:51:31 INFO - "project": "", 02:51:31 INFO - "product": "firefox", 02:51:31 INFO - "who": "archaeopteryx@coole-files.de", 02:51:31 INFO - "installer_path": "public/build/target.tar.bz2", 02:51:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:51:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:51:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:51:31 INFO - "stage_platform": "linux64-stylosequential", 02:51:31 INFO - "basedir": "/builds/slave/test", 02:51:31 INFO - "buildnumber": 137, 02:51:31 INFO - "platform": "ubuntu64_hw_styloseq", 02:51:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:51:31 INFO - "slavebuilddir": "test", 02:51:31 INFO - "taskId": "L3xJo9IiTbKTUWEAXeT4Gw", 02:51:31 INFO - "branch": "mozilla-central", 02:51:31 INFO - "script_repo_revision": "production", 02:51:31 INFO - "revision": "fe6609d22dfdd710b11e3ac7773aff89f7a8d12c", 02:51:31 INFO - "slavename": "talos-linux64-ix-010", 02:51:31 INFO - "repo_path": "mozilla-central" 02:51:31 INFO - } 02:51:31 INFO - Finding installer, test and symbols from parent task. 02:51:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3xJo9IiTbKTUWEAXeT4Gw'}, attempt #1 02:51:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L3xJo9IiTbKTUWEAXeT4Gw'}, attempt #1 02:51:32 INFO - Task dependencies: Ph1H-2ZlRnGCNKdcz7C8dw 02:51:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw'}, attempt #1 02:51:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:51:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 02:51:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip 02:51:32 INFO - Running post-action listener: _resource_record_post_action 02:51:32 INFO - [mozharness: 2017-08-06 09:51:32.948426Z] Finished read-buildbot-config step (success) 02:51:32 INFO - [mozharness: 2017-08-06 09:51:32.948737Z] Running download-and-extract step. 02:51:32 INFO - Running pre-action listener: _resource_record_pre_action 02:51:32 INFO - Running main action method: download_and_extract 02:51:32 INFO - mkdir: /builds/slave/test/build/tests 02:51:33 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')]} 02:51:33 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 02:51:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:51:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:51:33 INFO - Downloaded 989 bytes. 02:51:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:51:33 INFO - Using the following test package requirements: 02:51:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:51:33 INFO - u'common': [u'target.common.tests.zip'], 02:51:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:51:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:51:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:51:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:51:33 INFO - u'mozbase': [u'target.common.tests.zip'], 02:51:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:51:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:51:33 INFO - u'web-platform': [u'target.common.tests.zip', 02:51:33 INFO - u'target.web-platform.tests.tar.gz'], 02:51:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:51:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:51:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 02:51:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:51:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 02:51:34 INFO - Content-Length response header: 54284831 02:51:34 INFO - Bytes received: 54284831 02:51:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:51:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 02:51:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:51:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 02:51:46 INFO - Content-Length response header: 54284831 02:51:46 INFO - Bytes received: 54284831 02:51:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip 02:51:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:51:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip into memory 02:51:59 INFO - Content-Length response header: 14496008 02:51:59 INFO - Bytes received: 14496008 02:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:59 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:51:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:51:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:52:00 INFO - Downloaded 61880648 bytes. 02:52:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:52:00 INFO - mkdir: /builds/slave/test/properties 02:52:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:00 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:00 INFO - Contents: 02:52:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:52:00 INFO - Running post-action listener: _resource_record_post_action 02:52:00 INFO - Running post-action listener: set_extra_try_arguments 02:52:00 INFO - [mozharness: 2017-08-06 09:52:00.932667Z] Finished download-and-extract step (success) 02:52:00 INFO - [mozharness: 2017-08-06 09:52:00.932769Z] Running populate-webroot step. 02:52:00 INFO - Running pre-action listener: _resource_record_pre_action 02:52:00 INFO - Running main action method: populate_webroot 02:52:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:00 INFO - 'tests': ['damp', 'tps']}, 02:52:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:52:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:52:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:52:00 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:00 INFO - 'ts_paint', 02:52:00 INFO - 'tpaint', 02:52:00 INFO - 'sessionrestore', 02:52:00 INFO - 'sessionrestore_many_windows', 02:52:00 INFO - 'sessionrestore_no_auto_restore', 02:52:00 INFO - 'tabpaint']}, 02:52:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:52:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:52:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:00 INFO - 'tsvgr_opacity', 02:52:00 INFO - 'tart', 02:52:00 INFO - 'tscrollx', 02:52:00 INFO - 'tsvg_static']}, 02:52:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:00 INFO - 'talos_options': ['--mitmproxy', 02:52:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:00 INFO - '--firstNonBlankPaint'], 02:52:00 INFO - 'tests': ['tp6_google', 02:52:00 INFO - 'tp6_youtube', 02:52:00 INFO - 'tp6_amazon', 02:52:00 INFO - 'tp6_facebook']}, 02:52:00 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:00 INFO - 'talos_options': ['--stylo', 02:52:00 INFO - '--mitmproxy', 02:52:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:00 INFO - '--firstNonBlankPaint'], 02:52:00 INFO - 'tests': ['tp6_google', 02:52:00 INFO - 'tp6_youtube', 02:52:00 INFO - 'tp6_amazon', 02:52:00 INFO - 'tp6_facebook']}, 02:52:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:00 INFO - 'talos_options': ['--stylo', 02:52:00 INFO - '--stylo-threads=1', 02:52:00 INFO - '--mitmproxy', 02:52:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:00 INFO - '--firstNonBlankPaint'], 02:52:00 INFO - 'tests': ['tp6_google', 02:52:00 INFO - 'tp6_youtube', 02:52:00 INFO - 'tp6_amazon', 02:52:00 INFO - 'tp6_facebook']}, 02:52:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:00 INFO - 'talos_options': ['--xperf_path', 02:52:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:00 INFO - 'tests': ['tp5n']}}} 02:52:00 INFO - Running post-action listener: _resource_record_post_action 02:52:00 INFO - [mozharness: 2017-08-06 09:52:00.941182Z] Finished populate-webroot step (success) 02:52:00 INFO - [mozharness: 2017-08-06 09:52:00.941272Z] Running create-virtualenv step. 02:52:00 INFO - Running pre-action listener: _resource_record_pre_action 02:52:00 INFO - Running main action method: create_virtualenv 02:52:00 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:00 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 02:52:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:52:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:01 INFO - Using real prefix '/usr' 02:52:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:03 INFO - Installing pip.................done. 02:52:03 INFO - Return code: 0 02:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:03 INFO - Reading from file tmpfile_stdout 02:52:04 INFO - Output received: 02:52:04 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) 02:52:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:04 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')]} 02:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:04 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')]} 02:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:04 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:04 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 02:52:04 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 02:52:04 INFO - Using env: {'DISPLAY': ':0', 02:52:04 INFO - 'HOME': '/home/cltbld', 02:52:04 INFO - 'LANG': 'en_US.UTF-8', 02:52:04 INFO - 'LANGUAGE': 'en_US:en', 02:52:04 INFO - 'LOGNAME': 'cltbld', 02:52:04 INFO - 'MAIL': '/var/mail/cltbld', 02:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:04 INFO - 'MOZ_NO_REMOTE': '1', 02:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:04 INFO - 'NO_EM_RESTART': '1', 02:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:04 INFO - 'PWD': '/builds/slave/test', 02:52:04 INFO - 'SHELL': '/bin/bash', 02:52:04 INFO - 'SHLVL': '1', 02:52:04 INFO - 'TERM': 'linux', 02:52:04 INFO - 'TMOUT': '86400', 02:52:04 INFO - 'USER': 'cltbld', 02:52:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:04 INFO - '_': '/tools/buildbot/bin/python'} 02:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:04 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 02:52:04 INFO - Cleaning up... 02:52:04 INFO - Return code: 0 02:52:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52:04 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')]} 02:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:04 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')]} 02:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:04 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:04 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 02:52:04 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 02:52:04 INFO - Using env: {'DISPLAY': ':0', 02:52:04 INFO - 'HOME': '/home/cltbld', 02:52:04 INFO - 'LANG': 'en_US.UTF-8', 02:52:04 INFO - 'LANGUAGE': 'en_US:en', 02:52:04 INFO - 'LOGNAME': 'cltbld', 02:52:04 INFO - 'MAIL': '/var/mail/cltbld', 02:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:04 INFO - 'MOZ_NO_REMOTE': '1', 02:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:04 INFO - 'NO_EM_RESTART': '1', 02:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:04 INFO - 'PWD': '/builds/slave/test', 02:52:04 INFO - 'SHELL': '/bin/bash', 02:52:04 INFO - 'SHLVL': '1', 02:52:04 INFO - 'TERM': 'linux', 02:52:04 INFO - 'TMOUT': '86400', 02:52:04 INFO - 'USER': 'cltbld', 02:52:04 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:04 INFO - '_': '/tools/buildbot/bin/python'} 02:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:04 INFO - Downloading/unpacking psutil>=3.1.1 02:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:05 INFO - Installing collected packages: psutil 02:52:05 INFO - Running setup.py install for psutil 02:52:05 INFO - building 'psutil._psutil_linux' extension 02:52:05 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 02:52:06 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 02:52:06 INFO - building 'psutil._psutil_posix' extension 02:52:06 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 02:52:07 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 02:52:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:07 INFO - Successfully installed psutil 02:52:07 INFO - Cleaning up... 02:52:07 INFO - Return code: 0 02:52:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52: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')]} 02:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:07 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:07 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 02:52:07 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 02:52:07 INFO - Using env: {'DISPLAY': ':0', 02:52:07 INFO - 'HOME': '/home/cltbld', 02:52:07 INFO - 'LANG': 'en_US.UTF-8', 02:52:07 INFO - 'LANGUAGE': 'en_US:en', 02:52:07 INFO - 'LOGNAME': 'cltbld', 02:52:07 INFO - 'MAIL': '/var/mail/cltbld', 02:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:07 INFO - 'MOZ_NO_REMOTE': '1', 02:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:07 INFO - 'NO_EM_RESTART': '1', 02:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:07 INFO - 'PWD': '/builds/slave/test', 02:52:07 INFO - 'SHELL': '/bin/bash', 02:52:07 INFO - 'SHLVL': '1', 02:52:07 INFO - 'TERM': 'linux', 02:52:07 INFO - 'TMOUT': '86400', 02:52:07 INFO - 'USER': 'cltbld', 02:52:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:07 INFO - '_': '/tools/buildbot/bin/python'} 02:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:07 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 02:52:07 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 02:52:07 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 02:52:07 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 02:52:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:08 INFO - Installing collected packages: mozsystemmonitor 02:52:08 INFO - Running setup.py install for mozsystemmonitor 02:52:08 INFO - Successfully installed mozsystemmonitor 02:52:08 INFO - Cleaning up... 02:52:08 INFO - Return code: 0 02:52:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:08 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:08 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 02:52:08 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 02:52:08 INFO - Using env: {'DISPLAY': ':0', 02:52:08 INFO - 'HOME': '/home/cltbld', 02:52:08 INFO - 'LANG': 'en_US.UTF-8', 02:52:08 INFO - 'LANGUAGE': 'en_US:en', 02:52:08 INFO - 'LOGNAME': 'cltbld', 02:52:08 INFO - 'MAIL': '/var/mail/cltbld', 02:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:08 INFO - 'MOZ_NO_REMOTE': '1', 02:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:08 INFO - 'NO_EM_RESTART': '1', 02:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:08 INFO - 'PWD': '/builds/slave/test', 02:52:08 INFO - 'SHELL': '/bin/bash', 02:52:08 INFO - 'SHLVL': '1', 02:52:08 INFO - 'TERM': 'linux', 02:52:08 INFO - 'TMOUT': '86400', 02:52:08 INFO - 'USER': 'cltbld', 02:52:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:08 INFO - '_': '/tools/buildbot/bin/python'} 02:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:52:08 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 02:52:08 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 02:52:08 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 02:52:08 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 02:52:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:10 INFO - warning: no files found matching '*.txt' 02:52:10 INFO - no previously-included directories found matching 'build' 02:52:10 INFO - no previously-included directories found matching 'dist' 02:52:10 INFO - no previously-included directories found matching '.git*' 02:52:10 INFO - Installing collected packages: jsonschema, functools32 02:52:10 INFO - Running setup.py install for functools32 02:52:10 INFO - warning: no files found matching '*.txt' 02:52:10 INFO - no previously-included directories found matching 'build' 02:52:10 INFO - no previously-included directories found matching 'dist' 02:52:10 INFO - no previously-included directories found matching '.git*' 02:52:10 INFO - Successfully installed jsonschema functools32 02:52:10 INFO - Cleaning up... 02:52:10 INFO - Return code: 0 02:52:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:10 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:10 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 02:52:10 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 02:52:10 INFO - Using env: {'DISPLAY': ':0', 02:52:10 INFO - 'HOME': '/home/cltbld', 02:52:10 INFO - 'LANG': 'en_US.UTF-8', 02:52:10 INFO - 'LANGUAGE': 'en_US:en', 02:52:10 INFO - 'LOGNAME': 'cltbld', 02:52:10 INFO - 'MAIL': '/var/mail/cltbld', 02:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:10 INFO - 'MOZ_NO_REMOTE': '1', 02:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:10 INFO - 'NO_EM_RESTART': '1', 02:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:10 INFO - 'PWD': '/builds/slave/test', 02:52:10 INFO - 'SHELL': '/bin/bash', 02:52:10 INFO - 'SHLVL': '1', 02:52:10 INFO - 'TERM': 'linux', 02:52:10 INFO - 'TMOUT': '86400', 02:52:10 INFO - 'USER': 'cltbld', 02:52:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:10 INFO - '_': '/tools/buildbot/bin/python'} 02:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:52:10 INFO - Cleaning up... 02:52:10 INFO - Return code: 0 02:52:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:10 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:10 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 02:52:10 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 02:52:10 INFO - Using env: {'DISPLAY': ':0', 02:52:10 INFO - 'HOME': '/home/cltbld', 02:52:10 INFO - 'LANG': 'en_US.UTF-8', 02:52:10 INFO - 'LANGUAGE': 'en_US:en', 02:52:10 INFO - 'LOGNAME': 'cltbld', 02:52:10 INFO - 'MAIL': '/var/mail/cltbld', 02:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:10 INFO - 'MOZ_NO_REMOTE': '1', 02:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:10 INFO - 'NO_EM_RESTART': '1', 02:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:10 INFO - 'PWD': '/builds/slave/test', 02:52:10 INFO - 'SHELL': '/bin/bash', 02:52:10 INFO - 'SHLVL': '1', 02:52:10 INFO - 'TERM': 'linux', 02:52:10 INFO - 'TMOUT': '86400', 02:52:10 INFO - 'USER': 'cltbld', 02:52:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:10 INFO - '_': '/tools/buildbot/bin/python'} 02:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 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 02:52:12 INFO - Downloading docopt-0.6.1.tar.gz 02:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:12 INFO - Running setup.py install for blobuploader 02:52:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:12 INFO - Running setup.py install for requests 02:52:13 INFO - Running setup.py install for docopt 02:52:13 INFO - Successfully installed blobuploader requests docopt 02:52:13 INFO - Cleaning up... 02:52:13 INFO - Return code: 0 02:52:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:13 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')]} 02:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:13 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')]} 02:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:13 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:13 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 02:52:13 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 02:52:13 INFO - Using env: {'DISPLAY': ':0', 02:52:13 INFO - 'HOME': '/home/cltbld', 02:52:13 INFO - 'LANG': 'en_US.UTF-8', 02:52:13 INFO - 'LANGUAGE': 'en_US:en', 02:52:13 INFO - 'LOGNAME': 'cltbld', 02:52:13 INFO - 'MAIL': '/var/mail/cltbld', 02:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:13 INFO - 'MOZ_NO_REMOTE': '1', 02:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:13 INFO - 'NO_EM_RESTART': '1', 02:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:13 INFO - 'PWD': '/builds/slave/test', 02:52:13 INFO - 'SHELL': '/bin/bash', 02:52:13 INFO - 'SHLVL': '1', 02:52:13 INFO - 'TERM': 'linux', 02:52:13 INFO - 'TMOUT': '86400', 02:52:13 INFO - 'USER': 'cltbld', 02:52:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:13 INFO - '_': '/tools/buildbot/bin/python'} 02:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:13 INFO - Running setup.py (path:/tmp/pip-j3BxdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:13 INFO - Running setup.py (path:/tmp/pip-VG1Db6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:13 INFO - Running setup.py (path:/tmp/pip-v6_zbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:13 INFO - Running setup.py (path:/tmp/pip-s9pam0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:13 INFO - Running setup.py (path:/tmp/pip-bqH3Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:13 INFO - Running setup.py (path:/tmp/pip-NO3jos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:13 INFO - Running setup.py (path:/tmp/pip-D4Ym5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:13 INFO - Running setup.py (path:/tmp/pip-6C847L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:13 INFO - Running setup.py (path:/tmp/pip-gtkdN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:14 INFO - Running setup.py (path:/tmp/pip-R8S82m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:14 INFO - Running setup.py (path:/tmp/pip-UbZ_XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:14 INFO - Running setup.py (path:/tmp/pip-B7PhsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:14 INFO - Running setup.py (path:/tmp/pip-ab_j5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:14 INFO - Running setup.py (path:/tmp/pip-SEJAOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:14 INFO - Running setup.py (path:/tmp/pip-UGek5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:14 INFO - Running setup.py (path:/tmp/pip-XlkWQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:14 INFO - Running setup.py (path:/tmp/pip-cfTpEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:14 INFO - Running setup.py install for manifestparser 02:52:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:14 INFO - Running setup.py install for mozcrash 02:52:14 INFO - Running setup.py install for mozdebug 02:52:14 INFO - Running setup.py install for mozdevice 02:52:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for mozfile 02:52:15 INFO - Running setup.py install for mozhttpd 02:52:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for mozinfo 02:52:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for mozInstall 02:52:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for mozleak 02:52:15 INFO - Running setup.py install for mozlog 02:52:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for moznetwork 02:52:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for mozprocess 02:52:15 INFO - Running setup.py install for mozprofile 02:52:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:15 INFO - Running setup.py install for mozrunner 02:52:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:16 INFO - Running setup.py install for mozscreenshot 02:52:16 INFO - Running setup.py install for moztest 02:52:16 INFO - Running setup.py install for mozversion 02:52:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:16 INFO - Cleaning up... 02:52:16 INFO - Return code: 0 02:52:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:16 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')]} 02:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:16 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')]} 02:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:16 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:16 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 02:52:16 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 02:52:16 INFO - Using env: {'DISPLAY': ':0', 02:52:16 INFO - 'HOME': '/home/cltbld', 02:52:16 INFO - 'LANG': 'en_US.UTF-8', 02:52:16 INFO - 'LANGUAGE': 'en_US:en', 02:52:16 INFO - 'LOGNAME': 'cltbld', 02:52:16 INFO - 'MAIL': '/var/mail/cltbld', 02:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:16 INFO - 'MOZ_NO_REMOTE': '1', 02:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:16 INFO - 'NO_EM_RESTART': '1', 02:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:16 INFO - 'PWD': '/builds/slave/test', 02:52:16 INFO - 'SHELL': '/bin/bash', 02:52:16 INFO - 'SHLVL': '1', 02:52:16 INFO - 'TERM': 'linux', 02:52:16 INFO - 'TMOUT': '86400', 02:52:16 INFO - 'USER': 'cltbld', 02:52:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:16 INFO - '_': '/tools/buildbot/bin/python'} 02:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:16 INFO - Running setup.py (path:/tmp/pip-uFIWPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:16 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)) 02:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:16 INFO - Running setup.py (path:/tmp/pip-9YTRkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:16 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)) 02:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:16 INFO - Running setup.py (path:/tmp/pip-M1Nwpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:16 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)) 02:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:16 INFO - Running setup.py (path:/tmp/pip-QQhe_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:16 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)) 02:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:16 INFO - Running setup.py (path:/tmp/pip-K6cdju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:16 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)) 02:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:17 INFO - Running setup.py (path:/tmp/pip-BI42pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:17 INFO - Running setup.py (path:/tmp/pip-bd5dF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:17 INFO - Running setup.py (path:/tmp/pip-Gnz9VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:17 INFO - Running setup.py (path:/tmp/pip-7XuI4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:17 INFO - Running setup.py (path:/tmp/pip-JvTb4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:17 INFO - Running setup.py (path:/tmp/pip-H4EktW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:17 INFO - Running setup.py (path:/tmp/pip-RDRlXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:17 INFO - Running setup.py (path:/tmp/pip-5SFK19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:17 INFO - Running setup.py (path:/tmp/pip-VLYouC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:17 INFO - Running setup.py (path:/tmp/pip-_LxZAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:17 INFO - Running setup.py (path:/tmp/pip-yqm1Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:17 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)) 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:17 INFO - Running setup.py (path:/tmp/pip-yImhIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:17 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)) 02:52:17 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)) 02:52:17 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)) 02:52:17 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)) 02:52:17 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)) 02:52:17 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)) 02:52:17 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)) 02:52:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:18 INFO - Downloading blessings-1.6.tar.gz 02:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:19 INFO - Installing collected packages: blessings 02:52:19 INFO - Running setup.py install for blessings 02:52:19 INFO - Successfully installed blessings 02:52:19 INFO - Cleaning up... 02:52:19 INFO - Return code: 0 02:52:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:19 INFO - Reading from file tmpfile_stdout 02:52:19 INFO - Current package versions: 02:52:19 INFO - argparse == 1.2.1 02:52:19 INFO - blessings == 1.6 02:52:19 INFO - blobuploader == 1.2.4 02:52:19 INFO - docopt == 0.6.1 02:52:19 INFO - functools32 == 3.2.3-2 02:52:19 INFO - jsonschema == 2.5.1 02:52:19 INFO - manifestparser == 1.1 02:52:19 INFO - mozInstall == 1.13 02:52:19 INFO - mozcrash == 1.0 02:52:19 INFO - mozdebug == 0.1 02:52:19 INFO - mozdevice == 0.51 02:52:19 INFO - mozfile == 1.2 02:52:19 INFO - mozhttpd == 0.7 02:52:19 INFO - mozinfo == 0.10 02:52:19 INFO - mozleak == 0.1 02:52:19 INFO - mozlog == 3.5 02:52:19 INFO - moznetwork == 0.27 02:52:19 INFO - mozprocess == 0.25 02:52:19 INFO - mozprofile == 0.28 02:52:19 INFO - mozrunner == 6.13 02:52:19 INFO - mozscreenshot == 0.1 02:52:19 INFO - mozsystemmonitor == 0.3 02:52:19 INFO - moztest == 0.8 02:52:19 INFO - mozversion == 1.4 02:52:19 INFO - psutil == 3.1.1 02:52:19 INFO - requests == 1.2.3 02:52:19 INFO - wsgiref == 0.1.2 02:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:19 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')]} 02:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:19 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')]} 02:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:19 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:19 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 02:52:19 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 02:52:19 INFO - Using env: {'DISPLAY': ':0', 02:52:19 INFO - 'HOME': '/home/cltbld', 02:52:19 INFO - 'LANG': 'en_US.UTF-8', 02:52:19 INFO - 'LANGUAGE': 'en_US:en', 02:52:19 INFO - 'LOGNAME': 'cltbld', 02:52:19 INFO - 'MAIL': '/var/mail/cltbld', 02:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:19 INFO - 'MOZ_NO_REMOTE': '1', 02:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:19 INFO - 'NO_EM_RESTART': '1', 02:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:19 INFO - 'PWD': '/builds/slave/test', 02:52:19 INFO - 'SHELL': '/bin/bash', 02:52:19 INFO - 'SHLVL': '1', 02:52:19 INFO - 'TERM': 'linux', 02:52:19 INFO - 'TMOUT': '86400', 02:52:19 INFO - 'USER': 'cltbld', 02:52:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:19 INFO - '_': '/tools/buildbot/bin/python'} 02:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 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)) 02:52:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:52:20 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)) 02:52:20 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)) 02:52:20 INFO - Installing collected packages: simplejson 02:52:20 INFO - Running setup.py install for simplejson 02:52:20 INFO - building 'simplejson._speedups' extension 02:52:20 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 02:52:21 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 02:52:21 INFO - Successfully installed simplejson 02:52:21 INFO - Cleaning up... 02:52:21 INFO - Return code: 0 02:52:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52:21 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')]} 02:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:21 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')]} 02:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:21 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 0x18f71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c66d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, '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': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', '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 02:52:21 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 02:52:21 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 02:52:21 INFO - Using env: {'DISPLAY': ':0', 02:52:21 INFO - 'HOME': '/home/cltbld', 02:52:21 INFO - 'LANG': 'en_US.UTF-8', 02:52:21 INFO - 'LANGUAGE': 'en_US:en', 02:52:21 INFO - 'LOGNAME': 'cltbld', 02:52:21 INFO - 'MAIL': '/var/mail/cltbld', 02:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:21 INFO - 'MOZ_NO_REMOTE': '1', 02:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:21 INFO - 'NO_EM_RESTART': '1', 02:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:21 INFO - 'PWD': '/builds/slave/test', 02:52:21 INFO - 'SHELL': '/bin/bash', 02:52:21 INFO - 'SHLVL': '1', 02:52:21 INFO - 'TERM': 'linux', 02:52:21 INFO - 'TMOUT': '86400', 02:52:21 INFO - 'USER': 'cltbld', 02:52:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:21 INFO - '_': '/tools/buildbot/bin/python'} 02:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:52:22 INFO - Cleaning up... 02:52:22 INFO - Return code: 0 02:52:22 INFO - Running post-action listener: _resource_record_post_action 02:52:22 INFO - Running post-action listener: _start_resource_monitoring 02:52:22 INFO - Starting resource monitoring. 02:52:22 INFO - [mozharness: 2017-08-06 09:52:22.102365Z] Finished create-virtualenv step (success) 02:52:22 INFO - [mozharness: 2017-08-06 09:52:22.103379Z] Running install step. 02:52:22 INFO - Running pre-action listener: _resource_record_pre_action 02:52:22 INFO - Running main action method: install 02:52:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:22 INFO - Reading from file tmpfile_stdout 02:52:22 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:22 INFO - Reading from file tmpfile_stdout 02:52:22 INFO - Output received: 02:52:22 INFO - Usage: mozinstall [options] installer 02:52:22 INFO - Options: 02:52:22 INFO - -h, --help show this help message and exit 02:52:22 INFO - -d DEST, --destination=DEST 02:52:22 INFO - Directory to install application into. [default: 02:52:22 INFO - "/builds/slave/test"] 02:52:22 INFO - --app=APP Application being installed. [default: firefox] 02:52:22 INFO - mkdir: /builds/slave/test/build/application 02:52:22 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'] 02:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:52:40 INFO - Reading from file tmpfile_stdout 02:52:40 INFO - Output received: 02:52:40 INFO - /builds/slave/test/build/application/firefox/firefox 02:52:40 INFO - Running post-action listener: _resource_record_post_action 02:52:40 INFO - [mozharness: 2017-08-06 09:52:40.420228Z] Finished install step (success) 02:52:40 INFO - [mozharness: 2017-08-06 09:52:40.420378Z] Running setup-mitmproxy step. 02:52:40 INFO - Running pre-action listener: _resource_record_pre_action 02:52:40 INFO - Running main action method: setup_mitmproxy 02:52:40 INFO - Skipping: mitmproxy is not required 02:52:40 INFO - Running post-action listener: _resource_record_post_action 02:52:40 INFO - [mozharness: 2017-08-06 09:52:40.421079Z] Finished setup-mitmproxy step (success) 02:52:40 INFO - [mozharness: 2017-08-06 09:52:40.421213Z] Running run-tests step. 02:52:40 INFO - Running pre-action listener: _resource_record_pre_action 02:52:40 INFO - Running pre-action listener: _set_gcov_prefix 02:52:40 INFO - Running main action method: run_tests 02:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:40 INFO - Python 2.7.3 02:52:40 INFO - Return code: 0 02:52:40 INFO - grabbing minidump binary from tooltool 02:52: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')]} 02:52:40 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 0x1c63eb0>, '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 0x1c64db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c65240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:40 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 02:52:40 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 02:52:40 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 02:52:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:40 INFO - Return code: 0 02:52:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:52:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:40 INFO - ENV: RUST_BACKTRACE is now 1 02:52:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:52:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:40 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/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 02:52:40 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/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 02:52:40 INFO - Using env: {'DISPLAY': ':0', 02:52:40 INFO - 'HOME': '/home/cltbld', 02:52:40 INFO - 'LANG': 'en_US.UTF-8', 02:52:40 INFO - 'LANGUAGE': 'en_US:en', 02:52:40 INFO - 'LOGNAME': 'cltbld', 02:52:40 INFO - 'MAIL': '/var/mail/cltbld', 02:52:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:40 INFO - 'MOZ_NO_REMOTE': '1', 02:52:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:40 INFO - 'NO_EM_RESTART': '1', 02:52:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:40 INFO - 'PWD': '/builds/slave/test', 02:52:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:40 INFO - 'RUST_BACKTRACE': '1', 02:52:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:52:40 INFO - 'SHELL': '/bin/bash', 02:52:40 INFO - 'SHLVL': '1', 02:52:40 INFO - 'STYLO_FORCE_ENABLED': '1', 02:52:40 INFO - 'TERM': 'linux', 02:52:40 INFO - 'TMOUT': '86400', 02:52:40 INFO - 'USER': 'cltbld', 02:52:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716', 02:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:40 INFO - '_': '/tools/buildbot/bin/python'} 02:52:40 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/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 02:52:41 INFO - mozversion application_buildid: 20170806090558 02:52:41 INFO - mozversion application_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 02:52:41 INFO - mozversion application_display_name: Nightly 02:52:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:41 INFO - mozversion application_name: Firefox 02:52:41 INFO - mozversion application_remotingname: firefox 02:52:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:52:41 INFO - mozversion application_vendor: Mozilla 02:52:41 INFO - mozversion application_version: 57.0a1 02:52:41 INFO - mozversion platform_buildid: 20170806090558 02:52:41 INFO - mozversion platform_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 02:52:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:52:41 INFO - mozversion platform_version: 57.0a1 02:52:41 INFO - using testdate: 1502013161 02:52:41 INFO - actual date: 1502013161 02:52:41 INFO - starting webserver on 'localhost:41736' 02:52:41 INFO - SUITE-START | Running 2 tests 02:52:41 INFO - TEST-START | dromaeo_css 02:52:41 INFO - Initialising browser for dromaeo_css test... 02:52:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41736/getInfo.html -profile /tmp/tmp3WU2qG/profile 02:52:41 INFO - TEST-INFO | started process 3326 (/builds/slave/test/build/application/firefox/firefox http://localhost:41736/getInfo.html) 02:52:50 INFO - TEST-INFO | 3326: exit 0 02:52:50 INFO - Browser initialized. 02:52:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:50 INFO - TEST-INFO | started process 3551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3WU2qG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:51 INFO - PID 3551 | 02:52:51 INFO - PID 3551 | (/builds/slave/test/build/application/firefox/firefox:3605): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:52:51 INFO - PID 3551 | 02:53:02 INFO - PID 3551 | RSS: Main: 173420544 02:53:02 INFO - PID 3551 | 02:53:02 INFO - PID 3551 | serialization: Helvetica 02:53:02 INFO - PID 3551 | serialization: Arial 02:56:02 INFO - PID 3551 | Cycle 1(1): loaded http://localhost:41736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41736/tests/dromaeo/cssquery-ext.html) 02:56:03 INFO - PID 3551 | RSS: Main: 175546368 02:56:03 INFO - PID 3551 | 02:56:03 INFO - PID 3551 | serialization: Helvetica 02:56:03 INFO - PID 3551 | serialization: Arial 02:59:05 INFO - PID 3551 | Cycle 1(1): loaded http://localhost:41736/tests/dromaeo/cssquery-ext.html (next: http://localhost:41736/tests/dromaeo/cssquery-jquery.html) 02:59:06 INFO - PID 3551 | RSS: Main: 173449216 02:59:06 INFO - PID 3551 | 02:59:06 INFO - PID 3551 | serialization: Helvetica 02:59:06 INFO - PID 3551 | serialization: Arial 03:02:07 INFO - PID 3551 | Cycle 1(1): loaded http://localhost:41736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41736/tests/dromaeo/cssquery-mootools.html) 03:02:08 INFO - PID 3551 | RSS: Main: 175173632 03:02:08 INFO - PID 3551 | 03:02:08 INFO - PID 3551 | serialization: Helvetica 03:02:08 INFO - PID 3551 | serialization: Arial 03:05:10 INFO - PID 3551 | Cycle 1(1): loaded http://localhost:41736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41736/tests/dromaeo/cssquery-prototype.html) 03:05:11 INFO - PID 3551 | RSS: Main: 173420544 03:05:11 INFO - PID 3551 | 03:05:11 INFO - PID 3551 | serialization: Helvetica 03:05:11 INFO - PID 3551 | serialization: Arial 03:08:14 INFO - PID 3551 | Cycle 1(1): loaded http://localhost:41736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41736/tests/dromaeo/cssquery-yui.html) 03:08:15 INFO - PID 3551 | RSS: Main: 175390720 03:08:15 INFO - PID 3551 | 03:08:15 INFO - PID 3551 | serialization: Helvetica 03:08:15 INFO - PID 3551 | serialization: Arial 03:11:17 INFO - PID 3551 | Cycle 1(1): loaded http://localhost:41736/tests/dromaeo/cssquery-yui.html (next: http://localhost:41736/tests/dromaeo/cssquery-dojo.html) 03:11:17 INFO - PID 3551 | RSS: Main: 177471488 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | __start_tp_report 03:11:17 INFO - PID 3551 | _x_x_mozilla_page_load 03:11:17 INFO - PID 3551 | _x_x_mozilla_page_load_details 03:11:17 INFO - PID 3551 | |i|pagename|runs| 03:11:17 INFO - PID 3551 | |0;dojo.html;3146.7639927005475;3156.715895569398;3164.1614972032407;3183.538386933896;3241.092494101651;6172.783952561661;6212.316645169033;6297.590656607329;6354.872902541946;6368.936310636892;6265.216847894013;6321.304656487794;6325.46233570146;6399.36006399361;6404.103425520431;5618.410066942974;5698.572607054467;5795.4784069433745;5810.82567522975;5846.590738648296;5701.173329867167;5724.54203663708;5795.072788353864;5813.186153938452;5813.563982701293;5759.251297331341;5760.7695692172265;5803.303603567578;5833.82498525045;5834.708264586796;5647.3505546862225;5706.28671416073;5711.7144142792695;5771.624844385102;5799.797007104731;5709.743061562198;5747.396523365028;5775.335836378787;5796.13058041293;5801.622894511843;6156.445919867188;6165.290991535986;6238.407351301619;6264.404881536292;6281.59169653971;6706.26231114577;6715.429188518933;6817.0796942412635;6829.078074459934;6854.0404343391965;6676.83307917306;6762.661866906635;6815.284395138488;6877.243503214642;6898.931010689879;6288.937110628835;6300.4329610334835;6352.46004089653;6376.107344971708;6383.71273292703;6850.862982740317;6942.271061538567;6957.512974091765;6970.895436568456;7052.188998265163;6626.271110177877;6634.038064480624;6643.435307998778;6647.734090636321;6649.933500665028;6707.631080290631;6739.090222819955;6741.292164322774;6750.8649827004165;6758.05387245786;6711.7315307388135;6718.798436046926;6720.4287635550545;6721.529492935448;6726.562773419712;6661.666916654148;6725.293844146392;6742.6628668567355;6779.559328643622;6804.693788779417;5311.920321195185;5440.782368705208;5450.91823622646;5496.31296087989;5520.530754885799;4612.446506419184;4726.409198850144;4730.266808644666;4752.7623618818925;4758.571728544448;5771.884562308815;5837.854053648608;5839.386864379264;5845.386234445322;5851.648901065864;6741.056252124608;6771.932280677229;6774.966125169342;6866.279040700754;6892.620905850226;5678.205051292823;5730.226419433407;5732.369439361667;5818.883622327529;5828.795992140254;5873.442023007808;5892.646441213541;5913.881722365614;5914;5917.822465326047;6522.804315870531;6535.57518761279;6548.312427195171;6554.311797261219;6556.213254409501;6695.665216739046;6792.150981127359;6804.965975170093;6805.217399999064;6806.693698783665;5728.770849165987;6527.086207930798;6571.310012448624;6576.671166441563;6577.2436169841085;6554;6579.440747536513;6615.37153970372;6694.029365742038;6713.731450741916;6702.664866756741;6746.224184218681;6775.695093720696;6809.829754256183;6862.107925969792;6539;6594.571352862049;6598.439132673777;6602.933970660232;6611.041398997022;6528.314526974599;6602.933970660424;6631.966840165768;6636.303188165173;6656.068150459037;6344.651044192614;6458.935410646021;6506.642134682638;6583.9465685492005;6599.703013364314;6552.5740826848005;6613.470922326106;6694.665266736741;6733.764318248838;6750.122484077235;6303.243610766737;6405.679716014088;6409.807705768648;6425.293217746138;6518.380753828379 03:11:17 INFO - PID 3551 | |1;ext.html;808.3452403553123;819.8073452738602;849.0957130655851;865.3466632692316;875.4965894610597;41330;42153.15693686125;42231;42231.78884105579;42319;38814.417783733195;39065.804670976606;39071.80464097683;39175.80412097935;39285.41071883917;6935.44516438685;7036.155661320623;7041.8591628167405;7042.542234754725;7075.150981882181;6913.89629155563;6993.230744618088;7012.439004879598;7015.473839462035;7021.438284937193;6999.335063168991;7029.683664235122;7699.384049276073;7861.174576669453;7906.841863162762;7820.41346898982;7872.881906771403;7873.842523149534;7875.054993400771;7877.7636670899965;7583.62081895903;7673.079230492321;7836.059672839238;7862.01724784402;7873.055233372032;39818.402723958876;40024.799876000725;40081.59918400837;40140;40151.19697606061;3574.857005719768;3625.2024554597947;3628.727845411605;3630.909227269339;3633.5821380541047;32205.1948701282;32270.515942260885;32482.350352993046;32555.023349299558;32594;5080.517350851663;5107.616928730323;5123.052235336475;5131.7434128293435;5145.897082058375;199333;199918;200400;200415;200525;48044.519554804705;48063.279050814264;48123.5187648126;48134;48307.27539086917;51561.48438515642;51610.22584661233;51656.74171629118;51777.482225177264;51795;17084.48746537606;17326.480205593853;17332.740008899877;17358.479245622653;17360.826391736173;14375.28123593816;14379.568612941628;14382.208978506282;14389.712205755826;14405;14698.162729658792;14813.037152585048;14854.331555080047;14920.104793712411;15046.54860354191;5835.35811060783;5905.114232865105;5917.881642367214;5965.79119730816;6062.484069111358;974.9902500974899;1004.2468148888333;1005.6178652112296;1013.4020927652573;1021.9795604088025;22704.31887043391;22781.31656050321;22886;23132.190373337187;23210.419739506648;1073.8711354637494;1098.4397957041806;1100.785346857355;1101.2566517600749;1115.1859142825783;12054.216475929037;12109.33398663082;12233.632991010283;12289.938550307192;12320.260784352968;240427;243433;244911;245363;245701;44231.336529952074;45233.54766452359;51776.74111629418;52117.69705757387;53091.734541327045;1505.8268299145739;1514.2050423527517;1514.2504460292005;1518.3774652392467;1519.475780855603;27567.03515376952;27955.16134515968;28170.2957426066;28239.29401764972;28575.42849142964;38225.23549529049;38638;38646;38760;38782.6121738779;208626;210419;211429;211543;213215;32864.342713146085;33382;33399.49900751442;33410.16474588155;33417.49873751944;42874.57125428706;43079.35380969351;43167.13665726731;43585.34621980736;43806;32482.512762309056;32626.184345391554;32669.836650816593;32700;32946.34107317888;31905;32073.518897216094;32205.838970804994;32213.677863221066;32217;35147;35194.47208291826;35276.29447410986;35381.29237415289;35520.644793551735;31125.221869453446;31345.8432707835;31497.8425107873;31556.36887262288;32472.675273246965;23153.88423057874;23262.0695172198;25276.494470110127;25504.234872953843;26545 03:11:17 INFO - PID 3551 | |2;jquery.html;573.1687259206835;590.4744777148337;590.7223604905693;595.7170344086562;600.4445887554012;22468.77531224687;22618.66072008917;23511.882440587793;23555.057797688092;23572.174973875917;25736.227913162635;26465.867670661668;26710.465790684175;26732.732672673268;26798.196054118358;6631.635260060695;6791.3887750102485;6792.18493780747;6792.966035169818;6816.829579260533;6007.609505382158;6536.869262614745;6658.067870498134;6745.0556922030955;6745.763898263562;6503.479721622259;6508.739650413978;6509.121268628745;6515.609063456184;6517.837054073639;6486.870262594769;6497;6499.675016249169;6502.447291980187;6506.154199954023;6018.247719035121;6067.423594758491;6067.939320606782;6072.149899014142;6075.2405949256345;30031.69968300311;30573.541396879064;31208.21979450509;31376;31567.052988410385;1854;1906.9427917162507;1908.4179325305777;1908.6946088625753;1909.035936851881;19728;20180.19279228829;20368.898155509276;20370.796292037187;20478.488037799027;2364.243442098529;2459.397447625325;2493.6633554470277;2504.336350867022;2519;134967.32516337355;137892;138342.3082884589;139218;139481;14286.428542858377;14850.925745371203;15255.847441525442;15365.6158596036;15396.538103856903;23618.17336393218;23663.408414789425;23686.881565592063;23710.288691339287;23724;10385.430410619454;10603.41681207541;10618.787624247627;10722;10878.510467029002;10078.092971632588;10080.899191007997;10082.49587520621;10238.53926573306;10272.280940334254;9093.727188184364;9115.772105697279;9306.581203845843;9494.620215191453;9548.283878709124;2663.5738281874806;2740.821846579966;2742.890284388602;2871.9282017949718;2937.515309973873;951.7858481841669;978.3836183204678;979.3780949097375;989.5398639632461;991.2961797123978;19643.901780491007;19701.901490492455;19918.60162796736;20086.799132008786;20132.798672013094;1020.3775696824931;1025.661531694539;1033.1012019543045;1037.8495118207968;1043.5877828257946;11097.55609775616;11256.831147532794;11360.829587556193;11366.374849383363;11517.53929842797;507884;515067;522513;523796;540166;119172;122053;122228;122683;123313;1193.6154061289037;1213.2538488829482;1241.3420886929941;1249.506444954238;1254.7741406546909;18095.185716642518;18139.27442902269;18165.727514087564;18287.725684115016;18331;57042.42957570371;57194.7140264296;57330.42669573251;57752.71123644355;58556.70721646365;72543.63728181325;72728.27271727215;73084;73166.63416682882;73199.26800731925;12342.75314493723;12975.610731677687;14582;14843.92578037146;15179.392824286904;23150.652740209247;23654.763452365256;24070.51858962846;24259;24329;18442.446726598224;19426.12582433822;19427.4171774847;19443.12505937208;19455.8054419454;17038.74441883348;17551.473455796346;18365.54086147857;18393.080345982915;18434.26262949467;19444.8055519443;20230.494237643587;20300.187992480725;20311.4922126948;20360.796392036482;14936.551903442914;14937.85062149408;15163.09021458716;15198.848011519744;15213.391464341303;18793;18986.810131898503;19021.33425330107;19115.13981870847;19143.90428047851 03:11:17 INFO - PID 3551 | |3;mootools.html;1316.7103237287797;1388.021444881358;1406.5499040307102;1412.3997301147017;1413.2368520998662;13168.27574483403;13909.582712518628;13927;13950.372233249504;14206.928965355184;14847.480338188165;15190.164540950243;15202.467913623026;15203.695926081471;15208.69582608347;2665.533531631971;2711.959320610192;2713.579395193738;2714.0636480414323;2714.823536470123;2560.0655760647414;2622.6590543229354;2685.78513718902;2726.6727992640913;2738.1511731363244;2651.111877521033;2680.490706765718;2680.6515153030177;2681.302861256068;2683.3828219509523;2565.576679847823;2596.415806443554;2600.3109176068356;2604.843709377434;2668.85321307328;2531.734167912361;2581.3804686875014;2603.5964425514076;2608.243609353285;2621.829581077224;14119.152850828881;14179.716405671828;14227.857721422757;14235.572932812032;14270.714585708332;7818.648160832776;8113.107558168596;8121.675132994673;8123.593820308961;8127.2279133482225;5049.772760225798;5202.970841371868;5245.921311180336;5291.497307755757;5374.172781254392;1631.8123415807215;1634.256413331943;1636.1900859074715;1662.2104500362232;1675.3633619224738;21397.465063373384;21412.464688382915;21699.240526581652;21737.67393489099;21764.45588860275;6543.967280163569;6701.195856497252;6825.795226143224;6864.656767161622;6903;16254.674906501803;16281.104539250218;16287.674246515004;16291;16311.34754609826;7596.544207347577;7698.0762308523335;7748.883766743504;7763.456558040883;7775.028121484815;7034.577925324497;7084.4686648501565;7249.166345870187;7322.450816188807;7336.669849856769;4925.310456536088;5118.923216151761;5121.564667003347;5144.202648589475;5148.4851514848215;1371.5473893615083;1405.248192217159;1410.3582869794218;1425.7861320801755;1439.2443966917451;870.6125774030622;882.9249513791272;894.5571941888677;897.2687259883305;902.9232515236279;7809.414293927978;8210.137935516805;8237;8305.754136879517;8314.584270786558;959.2709540749081;967.7628980899725;971.6162115964155;972.3776782858976;976.7167521418709;5667.518260947865;5760.971195143998;5787.739551720183;5791;5973.940260597338;19601.31395401154;19634.410967670992;20228.898855505628;20255.59488810245;20311.28910488126;19015.90492047531;19278.807211927702;19391.4182574523;19478;19514.60970780605;10935.617253396093;11154.442277886235;11156.442177891073;11174.10607151426;11223.551057957753;8440.649496080598;8610.483370997761;8754;8861.778455538406;9035.412698174598;16791.41230056942;17186.742198866777;17358.739618905474;17499.475015749547;17538.298468061133;16807.41174058902;17440.47678569645;17646.1176941155;17905.731414028538;18070.63858722792;11662.650120496399;11743.41282935867;11763.176577639482;11816.172867899164;11884.881151188378;12442.75114497723;12532.686682832637;12541.74916501683;12558.560450384193;12564.183328083645;10540.736481587715;10582.576696932036;10601.893981060399;10642;10752.731181720519;10556.031306633642;10759.569617215537;10775.892241077489;10895.455227238448;10993.61522346714;9215.861762073708;9483.857742134012;9802.705918822447;9810.411375317504;9822.65620703272;6920.7231710731;6971.721131154697;6997.1253593300835;7043.7534686285735;7104.893426598502;7354.632268386452;7370.410367170721;7469.925300747141;7498.512596681198;7546.773596792105 03:11:17 INFO - PID 3551 | |4;prototype.html;487.37129103456544;501.39331408995116;526.7734874004177;530.4721801807202;538.717173483921;6316.621002739833;6337.714802833878;6392.712327945242;6399.336172595135;6406.558524332035;5965.731542080606;6197.48161700384;6227.346128656493;6235.690504993957;6252.312245652986;4981.452040275567;4981.850544483653;4990.65065445419;5042.932397716937;5082.288479612848;4986.700797952134;5017.448080711119;5025.9246111308175;5030.471800460954;5044.419891712463;4771.546703063221;4934.309196712446;4946.356973593446;4954.97522512387;4955.950440495603;4945.332380128691;4972.95567930735;4981.331254029904;4990.550850423443;5006.4743201964;4465.330200469923;4508.864734057984;4511.142882852248;4525.140223357552;4530.932036019462;6210.937890621081;6230.501559875199;6233.812985610393;6252.843678908063;6253.592366938761;5663.405342439026;5707.6290041147195;5754.395788442237;5779.364269930346;5780.682062486561;6587.374199451045;6625.337466253336;6642.667866606698;6649.301823308531;6663.268060095337;4907.9263811042865;4908.484609116027;4937.160682683916;4949.925751113737;4955.653104282702;7046;7117.71529138839;7137.89293160603;7148.428125749928;7171.713131474787;4959.652824302264;4978.77595508203;5005.174146265898;5028.2457631354855;5057.6459647824295;5078.111330517145;5105.132127538327;5109.233614957786;5112.258722485219;5128;5738.987031808334;5742.167385729046;5755.366909639936;5758.395368486333;5778.306603207558;6584.9012264816065;6601.933980660228;6617.437517810944;6627.547807311229;6715.664216789141;1668.2909763350528;1710.2133018811487;1720.4322573550699;1751.5533538947486;1767.8497327727287;1214.763121191377;1240.5968060380412;1246.5450110709526;1255.8241846141548;1263.7030297879992;5705.2012718219485;5755.827325180251;5760.243125846657;5786.508146807569;5805.735763052413;6638.900416493757;6707.3292670732535;6732.687126010381;6760.797176084725;6775.661216939134;5778.711064446761;5780.855478613068;5802.82591522255;5824.213731146241;5824.359320474744;3582.6775590197008;3591.982040089783;3608.314420260142;3626.8808824410985;3703.962890390641;6591.209054913345;6670.633115178712;6701.553932814585;6720.9663951680905;6736.966315168491;7090.220075791659;7091.184513780981;7099.574025558483;7103.147622285359;7106.253843346478;6577.177852768404;6639.336066393322;6646.767363142363;6677.3656502632175;6690.5316627836555;6868.62222577763;6875.209350924708;6896.172459304916;6898.827529311607;6917.481188910751;6796.592204467748;6824.454043676395;6833;6833.829154271183;6842.521023528305;6562.704678289584;6569.770058047945;6577.638229897401;6650.800475985729;6709.349806826373;5464.781408743605;5506.779728810803;5533.557315414838;5573.164025396223;5581.6930068846605;6768.424683901727;6814.2163651180745;6832.965835170792;6858.177018757581;6871.003704462725;6626.27111017778;6655.800325990228;6679.131712877295;6697.732090716317;6701.497387695845;6613.5370524062855;6647.734090636321;6651.43462805667;6657.933420665731;6703.698333575098;6189.195404597373;6363.427291543783;6462.806115816345;6501.674916254263;6614.453435427491;6639.008297510824;6665.966670166618;6685.598864068172;6700.6984685688285;6727.394534491919;6463.7737679181;6524.651125594687;6528.575642583407;6539.280679125197;6540.182477190351 03:11:17 INFO - PID 3551 | |5;yui.html;898.8741576179334;901.058393978293;921.7326975177199;926.296015028579;928.3965422475394;19043.809561904378;19678.11448484818;20221.696674549894;20238.797612023875;20244.89877550614;21937.890310548464;22445;22582.096716131335;22592.20927267546;22611.434714132156;1029.2229366828053;1071.3090056913286;1071.59815069349;1072.0137473524376;1072.0780129088978;1016.0550687860324;1055.5461151704765;1059.1156384419019;1059.253226475337;1059.5602824827688;1122.0126288865786;1131.3381671722052;1131.490829126892;1131.6491887514856;1131.8075927092373;1123.5505797680912;1125.189863298424;1125.499152876966;1127.1827924754527;1129.1305694615141;815.1807433529324;815.5188438821065;815.5636734347096;816.3958670583785;817.2685446525386;20227.898860505604;20525.076371563166;20731.585368292548;20733.963301834847;21040.473988150265;22478.55042899133;22596.32211033655;22998.42503937415;23158.42103947398;23158.76841231583;16940.491785246464;17306.48080557585;17312.480625581127;17432;17659.470215893543;3388.9661103389144;3404.4042292598697;3413.4709120086177;3422.178677117499;3425.0581090200144;123165;123597;123953;125808.99999999908;127401.36299318536;17038.914805425895;17118.14409279531;17554.91222543879;17684.557886052695;17778.288868445117;30781.84609076985;31415.842920785708;31457.685423145474;32289;32790;7831.216878312123;8311.16888311164;8510.191531804468;8758.080401557872;9189.081091890892;4411.558844115562;4520.864374068783;4529.818807247739;4533.886652833639;4538.160440318552;5273.815416460482;5307.150855863043;5380.757865896044;5394.190871369247;5403.540699040547;1067.9359238445718;1086.9728256793485;1098.181854518389;1100.1199040767515;1100.8403781451646;547.4963034008722;568.1477783325013;582.0280132179271;592.6414519215898;599.8320470268332;11535;11645.767084658259;11768.470418831173;12230.021598272117;12336.951359134395;565.2651552981108;566.9773209071674;569.1519635742713;569.6866723302168;589.8436914217735;5063.49365063498;5133.794648214104;5214.32213812202;5351.090314646442;5359.008583412081;100745.49627251964;101838;102269;103731;108014;90142.54928725315;91243.54378228067;91431.5428422867;92229;92897.535512322;79568.60215699;80339.59830200812;80551;82972.17027829644;85224.57387713021;10028.598856045677;10035.69892903214;10198;10446.425446600206;10481.580736770444;38059.2388152241;38258.61741382551;38462.230755385295;39267.41098883462;39726;46682.53317466782;47286.290705638756;47359.28961065656;48166.75916620394;48526;13367;13736.381862815997;14174.220417876702;14277.42890284377;14308.213048282445;19346.516337091685;19818.801811982274;19896.403107906786;20054.298099566444;20101.29645462402;16824;16934.745978810573;16960.830391696418;17045.744313835552;17489.737653934946;16838.57903552421;16994.15029248508;17078.402255920984;17245.396411125552;17300.394486192923;16029.839701602834;16105.275262612977;16118.194090295672;17909.552261193574;18276.360327388476;12131.878681213075;12161.513539458323;12391.194572352768;12611.43248553799;12701.36493175356;11868.347240901834;12627.558035468715;12678.809817852554;12712.6821829455;12861.935690321488 03:11:17 INFO - PID 3551 | __end_tp_report 03:11:17 INFO - PID 3551 | __start_cc_report 03:11:17 INFO - PID 3551 | _x_x_mozilla_cycle_collect,374 03:11:17 INFO - PID 3551 | __end_cc_report 03:11:17 INFO - PID 3551 | __startTimestamp1502014277604__endTimestamp 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | ------- Summary: start ------- 03:11:17 INFO - PID 3551 | Number of tests: 6 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | [#0] dojo.html Cycles:165 Average:6210.24 Median:6506.64 stddev:739.14 (11.4%) stddev-sans-first:701.25 03:11:17 INFO - PID 3551 | Values: 3146.8 3156.7 3164.2 3183.5 3241.1 6172.8 6212.3 6297.6 6354.9 6368.9 6265.2 6321.3 6325.5 6399.4 6404.1 5618.4 5698.6 5795.5 5810.8 5846.6 5701.2 5724.5 5795.1 5813.2 5813.6 5759.3 5760.8 5803.3 5833.8 5834.7 5647.4 5706.3 5711.7 5771.6 5799.8 5709.7 5747.4 5775.3 5796.1 5801.6 6156.4 6165.3 6238.4 6264.4 6281.6 6706.3 6715.4 6817.1 6829.1 6854.0 6676.8 6762.7 6815.3 6877.2 6898.9 6288.9 6300.4 6352.5 6376.1 6383.7 6850.9 6942.3 6957.5 6970.9 7052.2 6626.3 6634.0 6643.4 6647.7 6649.9 6707.6 6739.1 6741.3 6750.9 6758.1 6711.7 6718.8 6720.4 6721.5 6726.6 6661.7 6725.3 6742.7 6779.6 6804.7 5311.9 5440.8 5450.9 5496.3 5520.5 4612.4 4726.4 4730.3 4752.8 4758.6 5771.9 5837.9 5839.4 5845.4 5851.6 6741.1 6771.9 6775.0 6866.3 6892.6 5678.2 5730.2 5732.4 5818.9 5828.8 5873.4 5892.6 5913.9 5914.0 5917.8 6522.8 6535.6 6548.3 6554.3 6556.2 6695.7 6792.2 6805.0 6805.2 6806.7 5728.8 6527.1 6571.3 6576.7 6577.2 6554.0 6579.4 6615.4 6694.0 6713.7 6702.7 6746.2 6775.7 6809.8 6862.1 6539.0 6594.6 6598.4 6602.9 6611.0 6528.3 6602.9 6632.0 6636.3 6656.1 6344.7 6458.9 6506.6 6583.9 6599.7 6552.6 6613.5 6694.7 6733.8 6750.1 6303.2 6405.7 6409.8 6425.3 6518.4 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | [#1] ext.html Cycles:180 Average:38765.98 Median:35235.38 stddev:56770.20 (161.1%) stddev-sans-first:56857.91 03:11:17 INFO - PID 3551 | Values: 808.3 819.8 849.1 865.3 875.5 41330.0 42153.2 42231.0 42231.8 42319.0 38814.4 39065.8 39071.8 39175.8 39285.4 6935.4 7036.2 7041.9 7042.5 7075.2 6913.9 6993.2 7012.4 7015.5 7021.4 6999.3 7029.7 7699.4 7861.2 7906.8 7820.4 7872.9 7873.8 7875.1 7877.8 7583.6 7673.1 7836.1 7862.0 7873.1 39818.4 40024.8 40081.6 40140.0 40151.2 3574.9 3625.2 3628.7 3630.9 3633.6 32205.2 32270.5 32482.4 32555.0 32594.0 5080.5 5107.6 5123.1 5131.7 5145.9 199333.0 199918.0 200400.0 200415.0 200525.0 48044.5 48063.3 48123.5 48134.0 48307.3 51561.5 51610.2 51656.7 51777.5 51795.0 17084.5 17326.5 17332.7 17358.5 17360.8 14375.3 14379.6 14382.2 14389.7 14405.0 14698.2 14813.0 14854.3 14920.1 15046.5 5835.4 5905.1 5917.9 5965.8 6062.5 975.0 1004.2 1005.6 1013.4 1022.0 22704.3 22781.3 22886.0 23132.2 23210.4 1073.9 1098.4 1100.8 1101.3 1115.2 12054.2 12109.3 12233.6 12289.9 12320.3 240427.0 243433.0 244911.0 245363.0 245701.0 44231.3 45233.5 51776.7 52117.7 53091.7 1505.8 1514.2 1514.3 1518.4 1519.5 27567.0 27955.2 28170.3 28239.3 28575.4 38225.2 38638.0 38646.0 38760.0 38782.6 208626.0 210419.0 211429.0 211543.0 213215.0 32864.3 33382.0 33399.5 33410.2 33417.5 42874.6 43079.4 43167.1 43585.3 43806.0 32482.5 32626.2 32669.8 32700.0 32946.3 31905.0 32073.5 32205.8 32213.7 32217.0 35147.0 35194.5 35276.3 35381.3 35520.6 31125.2 31345.8 31497.8 31556.4 32472.7 23153.9 23262.1 25276.5 25504.2 26545.0 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | [#2] jquery.html Cycles:180 Average:36221.86 Median:22543.72 stddev:87647.93 (388.8%) stddev-sans-first:87852.93 03:11:17 INFO - PID 3551 | Values: 573.2 590.5 590.7 595.7 600.4 22468.8 22618.7 23511.9 23555.1 23572.2 25736.2 26465.9 26710.5 26732.7 26798.2 6631.6 6791.4 6792.2 6793.0 6816.8 6007.6 6536.9 6658.1 6745.1 6745.8 6503.5 6508.7 6509.1 6515.6 6517.8 6486.9 6497.0 6499.7 6502.4 6506.2 6018.2 6067.4 6067.9 6072.1 6075.2 30031.7 30573.5 31208.2 31376.0 31567.1 1854.0 1906.9 1908.4 1908.7 1909.0 19728.0 20180.2 20368.9 20370.8 20478.5 2364.2 2459.4 2493.7 2504.3 2519.0 134967.3 137892.0 138342.3 139218.0 139481.0 14286.4 14850.9 15255.8 15365.6 15396.5 23618.2 23663.4 23686.9 23710.3 23724.0 10385.4 10603.4 10618.8 10722.0 10878.5 10078.1 10080.9 10082.5 10238.5 10272.3 9093.7 9115.8 9306.6 9494.6 9548.3 2663.6 2740.8 2742.9 2871.9 2937.5 951.8 978.4 979.4 989.5 991.3 19643.9 19701.9 19918.6 20086.8 20132.8 1020.4 1025.7 1033.1 1037.8 1043.6 11097.6 11256.8 11360.8 11366.4 11517.5 507884.0 515067.0 522513.0 523796.0 540166.0 119172.0 122053.0 122228.0 122683.0 123313.0 1193.6 1213.3 1241.3 1249.5 1254.8 18095.2 18139.3 18165.7 18287.7 18331.0 57042.4 57194.7 57330.4 57752.7 58556.7 72543.6 72728.3 73084.0 73166.6 73199.3 12342.8 12975.6 14582.0 14843.9 15179.4 23150.7 23654.8 24070.5 24259.0 24329.0 18442.4 19426.1 19427.4 19443.1 19455.8 17038.7 17551.5 18365.5 18393.1 18434.3 19444.8 20230.5 20300.2 20311.5 20360.8 14936.6 14937.9 15163.1 15198.8 15213.4 18793.0 18986.8 19021.3 19115.1 19143.9 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | [#3] mootools.html Cycles:180 Average:8847.68 Median:2601.95 stddev:5932.61 (228.0%) stddev-sans-first:5922.26 03:11:17 INFO - PID 3551 | Values: 1316.7 1388.0 1406.5 1412.4 1413.2 13168.3 13909.6 13927.0 13950.4 14206.9 14847.5 15190.2 15202.5 15203.7 15208.7 2665.5 2712.0 2713.6 2714.1 2714.8 2560.1 2622.7 2685.8 2726.7 2738.2 2651.1 2680.5 2680.7 2681.3 2683.4 2565.6 2596.4 2600.3 2604.8 2668.9 2531.7 2581.4 2603.6 2608.2 2621.8 14119.2 14179.7 14227.9 14235.6 14270.7 7818.6 8113.1 8121.7 8123.6 8127.2 5049.8 5203.0 5245.9 5291.5 5374.2 1631.8 1634.3 1636.2 1662.2 1675.4 21397.5 21412.5 21699.2 21737.7 21764.5 6544.0 6701.2 6825.8 6864.7 6903.0 16254.7 16281.1 16287.7 16291.0 16311.3 7596.5 7698.1 7748.9 7763.5 7775.0 7034.6 7084.5 7249.2 7322.5 7336.7 4925.3 5118.9 5121.6 5144.2 5148.5 1371.5 1405.2 1410.4 1425.8 1439.2 870.6 882.9 894.6 897.3 902.9 7809.4 8210.1 8237.0 8305.8 8314.6 959.3 967.8 971.6 972.4 976.7 5667.5 5761.0 5787.7 5791.0 5973.9 19601.3 19634.4 20228.9 20255.6 20311.3 19015.9 19278.8 19391.4 19478.0 19514.6 10935.6 11154.4 11156.4 11174.1 11223.6 8440.6 8610.5 8754.0 8861.8 9035.4 16791.4 17186.7 17358.7 17499.5 17538.3 16807.4 17440.5 17646.1 17905.7 18070.6 11662.7 11743.4 11763.2 11816.2 11884.9 12442.8 12532.7 12541.7 12558.6 12564.2 10540.7 10582.6 10601.9 10642.0 10752.7 10556.0 10759.6 10775.9 10895.5 10993.6 9215.9 9483.9 9802.7 9810.4 9822.7 6920.7 6971.7 6997.1 7043.8 7104.9 7354.6 7370.4 7469.9 7498.5 7546.8 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | [#4] prototype.html Cycles:180 Average:5600.44 Median:6232.16 stddev:1584.96 (25.4%) stddev-sans-first:1542.24 03:11:17 INFO - PID 3551 | Values: 487.4 501.4 526.8 530.5 538.7 6316.6 6337.7 6392.7 6399.3 6406.6 5965.7 6197.5 6227.3 6235.7 6252.3 4981.5 4981.9 4990.7 5042.9 5082.3 4986.7 5017.4 5025.9 5030.5 5044.4 4771.5 4934.3 4946.4 4955.0 4956.0 4945.3 4973.0 4981.3 4990.6 5006.5 4465.3 4508.9 4511.1 4525.1 4530.9 6210.9 6230.5 6233.8 6252.8 6253.6 5663.4 5707.6 5754.4 5779.4 5780.7 6587.4 6625.3 6642.7 6649.3 6663.3 4907.9 4908.5 4937.2 4949.9 4955.7 7046.0 7117.7 7137.9 7148.4 7171.7 4959.7 4978.8 5005.2 5028.2 5057.6 5078.1 5105.1 5109.2 5112.3 5128.0 5739.0 5742.2 5755.4 5758.4 5778.3 6584.9 6601.9 6617.4 6627.5 6715.7 1668.3 1710.2 1720.4 1751.6 1767.8 1214.8 1240.6 1246.5 1255.8 1263.7 5705.2 5755.8 5760.2 5786.5 5805.7 6638.9 6707.3 6732.7 6760.8 6775.7 5778.7 5780.9 5802.8 5824.2 5824.4 3582.7 3592.0 3608.3 3626.9 3704.0 6591.2 6670.6 6701.6 6721.0 6737.0 7090.2 7091.2 7099.6 7103.1 7106.3 6577.2 6639.3 6646.8 6677.4 6690.5 6868.6 6875.2 6896.2 6898.8 6917.5 6796.6 6824.5 6833.0 6833.8 6842.5 6562.7 6569.8 6577.6 6650.8 6709.3 5464.8 5506.8 5533.6 5573.2 5581.7 6768.4 6814.2 6833.0 6858.2 6871.0 6626.3 6655.8 6679.1 6697.7 6701.5 6613.5 6647.7 6651.4 6657.9 6703.7 6189.2 6363.4 6462.8 6501.7 6614.5 6639.0 6666.0 6685.6 6700.7 6727.4 6463.8 6524.7 6528.6 6539.3 6540.2 03:11:17 INFO - PID 3551 | 03:11:17 INFO - PID 3551 | [#5] yui.html Cycles:180 Average:22428.80 Median:20077.80 stddev:30192.63 (150.4%) stddev-sans-first:30234.04 03:11:17 INFO - PID 3551 | Values: 898.9 901.1 921.7 926.3 928.4 19043.8 19678.1 20221.7 20238.8 20244.9 21937.9 22445.0 22582.1 22592.2 22611.4 1029.2 1071.3 1071.6 1072.0 1072.1 1016.1 1055.5 1059.1 1059.3 1059.6 1122.0 1131.3 1131.5 1131.6 1131.8 1123.6 1125.2 1125.5 1127.2 1129.1 815.2 815.5 815.6 816.4 817.3 20227.9 20525.1 20731.6 20734.0 21040.5 22478.6 22596.3 22998.4 23158.4 23158.8 16940.5 17306.5 17312.5 17432.0 17659.5 3389.0 3404.4 3413.5 3422.2 3425.1 123165.0 123597.0 123953.0 125809.0 127401.4 17038.9 17118.1 17554.9 17684.6 17778.3 30781.8 31415.8 31457.7 32289.0 32790.0 7831.2 8311.2 8510.2 8758.1 9189.1 4411.6 4520.9 4529.8 4533.9 4538.2 5273.8 5307.2 5380.8 5394.2 5403.5 1067.9 1087.0 1098.2 1100.1 1100.8 547.5 568.1 582.0 592.6 599.8 11535.0 11645.8 11768.5 12230.0 12337.0 565.3 567.0 569.2 569.7 589.8 5063.5 5133.8 5214.3 5351.1 5359.0 100745.5 101838.0 102269.0 103731.0 108014.0 90142.5 91243.5 91431.5 92229.0 92897.5 79568.6 80339.6 80551.0 82972.2 85224.6 10028.6 10035.7 10198.0 10446.4 10481.6 38059.2 38258.6 38462.2 39267.4 39726.0 46682.5 47286.3 47359.3 48166.8 48526.0 13367.0 13736.4 14174.2 14277.4 14308.2 19346.5 19818.8 19896.4 20054.3 20101.3 16824.0 16934.7 16960.8 17045.7 17489.7 16838.6 16994.2 17078.4 17245.4 17300.4 16029.8 16105.3 16118.2 17909.6 18276.4 12131.9 12161.5 12391.2 12611.4 12701.4 11868.3 12627.6 12678.8 12712.7 12861.9 03:11:17 INFO - PID 3551 | -------- Summary: end -------- 03:11:17 INFO - PID 3551 | 03:11:18 INFO - TEST-INFO | 3551: exit 0 03:11:18 INFO - TEST-OK | dromaeo_css | took 1117015ms 03:11:18 INFO - TEST-START | kraken 03:11:18 INFO - Initialising browser for kraken test... 03:11:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41736/getInfo.html -profile /tmp/tmpnYDRMi/profile 03:11:18 INFO - TEST-INFO | started process 3925 (/builds/slave/test/build/application/firefox/firefox http://localhost:41736/getInfo.html) 03:11:24 INFO - TEST-INFO | 3925: exit 0 03:11:24 INFO - Browser initialized. 03:11:24 INFO - Running cycle 1/1 for kraken test... 03:11:24 INFO - TEST-INFO | started process 4148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnYDRMi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:25 INFO - PID 4148 | 03:11:25 INFO - PID 4148 | (/builds/slave/test/build/application/firefox/firefox:4203): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:11:25 INFO - PID 4148 | 03:11:36 INFO - PID 4148 | RSS: Main: 173907968 03:11:36 INFO - PID 4148 | 03:11:36 INFO - PID 4148 | serialization: Helvetica 03:11:36 INFO - PID 4148 | serialization: Arial 03:11:38 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41736/tests/kraken/driver.html?testName=audio-beat-detection) 03:11:39 INFO - PID 4148 | RSS: Main: 179204096 03:11:39 INFO - PID 4148 | 03:11:39 INFO - PID 4148 | serialization: Helvetica 03:11:39 INFO - PID 4148 | serialization: Arial 03:11:42 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41736/tests/kraken/driver.html?testName=audio-dft) 03:11:43 INFO - PID 4148 | RSS: Main: 179261440 03:11:43 INFO - PID 4148 | 03:11:43 INFO - PID 4148 | serialization: Helvetica 03:11:43 INFO - PID 4148 | serialization: Arial 03:11:46 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41736/tests/kraken/driver.html?testName=audio-fft) 03:11:46 INFO - PID 4148 | RSS: Main: 174444544 03:11:46 INFO - PID 4148 | 03:11:46 INFO - PID 4148 | serialization: Helvetica 03:11:46 INFO - PID 4148 | serialization: Arial 03:11:49 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41736/tests/kraken/driver.html?testName=audio-oscillator) 03:11:49 INFO - PID 4148 | RSS: Main: 175386624 03:11:49 INFO - PID 4148 | 03:11:49 INFO - PID 4148 | serialization: Helvetica 03:11:49 INFO - PID 4148 | serialization: Arial 03:11:51 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:52 INFO - PID 4148 | RSS: Main: 175951872 03:11:52 INFO - PID 4148 | 03:11:52 INFO - PID 4148 | serialization: Helvetica 03:11:52 INFO - PID 4148 | serialization: Arial 03:11:55 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41736/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:56 INFO - PID 4148 | RSS: Main: 177524736 03:11:56 INFO - PID 4148 | 03:11:56 INFO - PID 4148 | serialization: Helvetica 03:11:56 INFO - PID 4148 | serialization: Arial 03:11:59 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41736/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:00 INFO - PID 4148 | RSS: Main: 176967680 03:12:00 INFO - PID 4148 | 03:12:00 INFO - PID 4148 | serialization: Helvetica 03:12:00 INFO - PID 4148 | serialization: Arial 03:12:03 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41736/tests/kraken/driver.html?testName=json-parse-financial) 03:12:04 INFO - PID 4148 | RSS: Main: 178012160 03:12:04 INFO - PID 4148 | 03:12:04 INFO - PID 4148 | serialization: Helvetica 03:12:04 INFO - PID 4148 | serialization: Arial 03:12:05 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:06 INFO - PID 4148 | RSS: Main: 178057216 03:12:06 INFO - PID 4148 | 03:12:06 INFO - PID 4148 | serialization: Helvetica 03:12:06 INFO - PID 4148 | serialization: Arial 03:12:08 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:08 INFO - PID 4148 | RSS: Main: 175177728 03:12:08 INFO - PID 4148 | 03:12:08 INFO - PID 4148 | serialization: Helvetica 03:12:08 INFO - PID 4148 | serialization: Arial 03:12:11 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:11 INFO - PID 4148 | RSS: Main: 175120384 03:12:11 INFO - PID 4148 | 03:12:11 INFO - PID 4148 | serialization: Helvetica 03:12:11 INFO - PID 4148 | serialization: Arial 03:12:14 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:15 INFO - PID 4148 | RSS: Main: 174731264 03:12:15 INFO - PID 4148 | 03:12:15 INFO - PID 4148 | serialization: Helvetica 03:12:15 INFO - PID 4148 | serialization: Arial 03:12:18 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:19 INFO - PID 4148 | RSS: Main: 175452160 03:12:19 INFO - PID 4148 | 03:12:19 INFO - PID 4148 | serialization: Helvetica 03:12:19 INFO - PID 4148 | serialization: Arial 03:12:20 INFO - PID 4148 | Cycle 1(1): loaded http://localhost:41736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41736/tests/kraken/driver.html?testName=ai-astar) 03:12:21 INFO - PID 4148 | RSS: Main: 176893952 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | __start_tp_report 03:12:21 INFO - PID 4148 | _x_x_mozilla_page_load 03:12:21 INFO - PID 4148 | _x_x_mozilla_page_load_details 03:12:21 INFO - PID 4148 | |i|pagename|runs| 03:12:21 INFO - PID 4148 | |0;ai-astar;97;107;109;107;107;108;110;99;108;116 03:12:21 INFO - PID 4148 | |1;audio-beat-detection;149;118;154;171;120;147;160;121;177;125 03:12:21 INFO - PID 4148 | |2;audio-dft;164;162;164;165;164;170;171;170;167;164 03:12:21 INFO - PID 4148 | |3;audio-fft;76;74;76;202;82;75;76;74;160;75 03:12:21 INFO - PID 4148 | |4;audio-oscillator;79;85;130;78;78;78;126;79;77;141 03:12:21 INFO - PID 4148 | |5;imaging-gaussian-blur;116;121;118;114;114;114;114;114;115;116 03:12:21 INFO - PID 4148 | |6;imaging-darkroom;151;152;151;152;151;152;152;153;153;150 03:12:21 INFO - PID 4148 | |7;imaging-desaturate;102;93;100;97;101;94;94;94;95;94 03:12:21 INFO - PID 4148 | |8;json-parse-financial;61;60;55;60;60;55;57;56;56;55 03:12:21 INFO - PID 4148 | |9;json-stringify-tinderbox;53;53;53;54;53;53;53;56;59;54 03:12:21 INFO - PID 4148 | |10;stanford-crypto-aes;77;91;80;88;89;79;79;83;84;81 03:12:21 INFO - PID 4148 | |11;stanford-crypto-ccm;132;139;125;136;130;130;125;125;135;169 03:12:21 INFO - PID 4148 | |12;stanford-crypto-pbkdf2;171;170;191;187;178;181;177;171;171;171 03:12:21 INFO - PID 4148 | |13;stanford-crypto-sha256-iterative;74;70;74;69;67;65;70;66;66;66 03:12:21 INFO - PID 4148 | __end_tp_report 03:12:21 INFO - PID 4148 | __start_cc_report 03:12:21 INFO - PID 4148 | _x_x_mozilla_cycle_collect,981 03:12:21 INFO - PID 4148 | __end_cc_report 03:12:21 INFO - PID 4148 | __startTimestamp1502014341117__endTimestamp 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | ------- Summary: start ------- 03:12:21 INFO - PID 4148 | Number of tests: 14 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#0] ai-astar Cycles:10 Average:106.80 Median:109.50 stddev:5.37 (4.9%) stddev-sans-first:4.37 03:12:21 INFO - PID 4148 | Values: 97.0 107.0 109.0 107.0 107.0 108.0 110.0 99.0 108.0 116.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.50 stddev:21.98 (14.5%) stddev-sans-first:23.25 03:12:21 INFO - PID 4148 | Values: 149.0 118.0 154.0 171.0 120.0 147.0 160.0 121.0 177.0 125.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:3.18 (1.9%) stddev-sans-first:3.28 03:12:21 INFO - PID 4148 | Values: 164.0 162.0 164.0 165.0 164.0 170.0 171.0 170.0 167.0 164.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#3] audio-fft Cycles:10 Average:97.00 Median:75.50 stddev:45.42 (60.2%) stddev-sans-first:47.54 03:12:21 INFO - PID 4148 | Values: 76.0 74.0 76.0 202.0 82.0 75.0 76.0 74.0 160.0 75.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:78.00 stddev:26.04 (33.4%) stddev-sans-first:26.96 03:12:21 INFO - PID 4148 | Values: 79.0 85.0 130.0 78.0 78.0 78.0 126.0 79.0 77.0 141.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:2.32 (2.0%) stddev-sans-first:2.46 03:12:21 INFO - PID 4148 | Values: 116.0 121.0 118.0 114.0 114.0 114.0 114.0 114.0 115.0 116.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 03:12:21 INFO - PID 4148 | Values: 151.0 152.0 151.0 152.0 151.0 152.0 152.0 153.0 153.0 150.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:94.00 stddev:3.37 (3.6%) stddev-sans-first:2.91 03:12:21 INFO - PID 4148 | Values: 102.0 93.0 100.0 97.0 101.0 94.0 94.0 94.0 95.0 94.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.50 stddev:2.46 (4.2%) stddev-sans-first:2.26 03:12:21 INFO - PID 4148 | Values: 61.0 60.0 55.0 60.0 60.0 55.0 57.0 56.0 56.0 55.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:53.50 stddev:1.97 (3.7%) stddev-sans-first:2.05 03:12:21 INFO - PID 4148 | Values: 53.0 53.0 53.0 54.0 53.0 53.0 53.0 56.0 59.0 54.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:4.79 (5.7%) stddev-sans-first:4.55 03:12:21 INFO - PID 4148 | Values: 77.0 91.0 80.0 88.0 89.0 79.0 79.0 83.0 84.0 81.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:133.50 stddev:13.04 (9.8%) stddev-sans-first:13.80 03:12:21 INFO - PID 4148 | Values: 132.0 139.0 125.0 136.0 130.0 130.0 125.0 125.0 135.0 169.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.50 stddev:7.50 (4.2%) stddev-sans-first:7.65 03:12:21 INFO - PID 4148 | Values: 171.0 170.0 191.0 187.0 178.0 181.0 177.0 171.0 171.0 171.0 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:3.30 (4.8%) stddev-sans-first:2.89 03:12:21 INFO - PID 4148 | Values: 74.0 70.0 74.0 69.0 67.0 65.0 70.0 66.0 66.0 66.0 03:12:21 INFO - PID 4148 | -------- Summary: end -------- 03:12:21 INFO - PID 4148 | 03:12:21 INFO - PID 4148 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:12:21 INFO - TEST-INFO | 4148: exit 0 03:12:21 INFO - TEST-OK | kraken | took 63428ms 03:12:21 INFO - SUITE-END | took 1180s 03:12:22 INFO - Completed test suite (00:19:40) 03:12:22 INFO - javascript benchmark 03:12:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8529.214386010006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.7639927005475, 3156.715895569398, 3164.1614972032407, 3183.538386933896, 3241.092494101651, 6172.783952561661, 6212.316645169033, 6297.590656607329, 6354.872902541946, 6368.936310636892, 6265.216847894013, 6321.304656487794, 6325.46233570146, 6399.36006399361, 6404.103425520431, 5618.410066942974, 5698.572607054467, 5795.4784069433745, 5810.82567522975, 5846.590738648296, 5701.173329867167, 5724.54203663708, 5795.072788353864, 5813.186153938452, 5813.563982701293, 5759.251297331341, 5760.7695692172265, 5803.303603567578, 5833.82498525045, 5834.708264586796, 5647.3505546862225, 5706.28671416073, 5711.7144142792695, 5771.624844385102, 5799.797007104731, 5709.743061562198, 5747.396523365028, 5775.335836378787, 5796.13058041293, 5801.622894511843, 6156.445919867188, 6165.290991535986, 6238.407351301619, 6264.404881536292, 6281.59169653971, 6706.26231114577, 6715.429188518933, 6817.0796942412635, 6829.078074459934, 6854.0404343391965, 6676.83307917306, 6762.661866906635, 6815.284395138488, 6877.243503214642, 6898.931010689879, 6288.937110628835, 6300.4329610334835, 6352.46004089653, 6376.107344971708, 6383.71273292703, 6850.862982740317, 6942.271061538567, 6957.512974091765, 6970.895436568456, 7052.188998265163, 6626.271110177877, 6634.038064480624, 6643.435307998778, 6647.734090636321, 6649.933500665028, 6707.631080290631, 6739.090222819955, 6741.292164322774, 6750.8649827004165, 6758.05387245786, 6711.7315307388135, 6718.798436046926, 6720.4287635550545, 6721.529492935448, 6726.562773419712, 6661.666916654148, 6725.293844146392, 6742.6628668567355, 6779.559328643622, 6804.693788779417, 5311.920321195185, 5440.782368705208, 5450.91823622646, 5496.31296087989, 5520.530754885799, 4612.446506419184, 4726.409198850144, 4730.266808644666, 4752.7623618818925, 4758.571728544448, 5771.884562308815, 5837.854053648608, 5839.386864379264, 5845.386234445322, 5851.648901065864, 6741.056252124608, 6771.932280677229, 6774.966125169342, 6866.279040700754, 6892.620905850226, 5678.205051292823, 5730.226419433407, 5732.369439361667, 5818.883622327529, 5828.795992140254, 5873.442023007808, 5892.646441213541, 5913.881722365614, 5914.0, 5917.822465326047, 6522.804315870531, 6535.57518761279, 6548.312427195171, 6554.311797261219, 6556.213254409501, 6695.665216739046, 6792.150981127359, 6804.965975170093, 6805.217399999064, 6806.693698783665, 5728.770849165987, 6527.086207930798, 6571.310012448624, 6576.671166441563, 6577.2436169841085, 6554.0, 6579.440747536513, 6615.37153970372, 6694.029365742038, 6713.731450741916, 6702.664866756741, 6746.224184218681, 6775.695093720696, 6809.829754256183, 6862.107925969792, 6539.0, 6594.571352862049, 6598.439132673777, 6602.933970660232, 6611.041398997022, 6528.314526974599, 6602.933970660424, 6631.966840165768, 6636.303188165173, 6656.068150459037, 6344.651044192614, 6458.935410646021, 6506.642134682638, 6583.9465685492005, 6599.703013364314, 6552.5740826848005, 6613.470922326106, 6694.665266736741, 6733.764318248838, 6750.122484077235, 6303.243610766737, 6405.679716014088, 6409.807705768648, 6425.293217746138, 6518.380753828379], "value": 6154.709970858846, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.3452403553123, 819.8073452738602, 849.0957130655851, 865.3466632692316, 875.4965894610597, 41330.0, 42153.15693686125, 42231.0, 42231.78884105579, 42319.0, 38814.417783733195, 39065.804670976606, 39071.80464097683, 39175.80412097935, 39285.41071883917, 6935.44516438685, 7036.155661320623, 7041.8591628167405, 7042.542234754725, 7075.150981882181, 6913.89629155563, 6993.230744618088, 7012.439004879598, 7015.473839462035, 7021.438284937193, 6999.335063168991, 7029.683664235122, 7699.384049276073, 7861.174576669453, 7906.841863162762, 7820.41346898982, 7872.881906771403, 7873.842523149534, 7875.054993400771, 7877.7636670899965, 7583.62081895903, 7673.079230492321, 7836.059672839238, 7862.01724784402, 7873.055233372032, 39818.402723958876, 40024.799876000725, 40081.59918400837, 40140.0, 40151.19697606061, 3574.857005719768, 3625.2024554597947, 3628.727845411605, 3630.909227269339, 3633.5821380541047, 32205.1948701282, 32270.515942260885, 32482.350352993046, 32555.023349299558, 32594.0, 5080.517350851663, 5107.616928730323, 5123.052235336475, 5131.7434128293435, 5145.897082058375, 199333.0, 199918.0, 200400.0, 200415.0, 200525.0, 48044.519554804705, 48063.279050814264, 48123.5187648126, 48134.0, 48307.27539086917, 51561.48438515642, 51610.22584661233, 51656.74171629118, 51777.482225177264, 51795.0, 17084.48746537606, 17326.480205593853, 17332.740008899877, 17358.479245622653, 17360.826391736173, 14375.28123593816, 14379.568612941628, 14382.208978506282, 14389.712205755826, 14405.0, 14698.162729658792, 14813.037152585048, 14854.331555080047, 14920.104793712411, 15046.54860354191, 5835.35811060783, 5905.114232865105, 5917.881642367214, 5965.79119730816, 6062.484069111358, 974.9902500974899, 1004.2468148888333, 1005.6178652112296, 1013.4020927652573, 1021.9795604088025, 22704.31887043391, 22781.31656050321, 22886.0, 23132.190373337187, 23210.419739506648, 1073.8711354637494, 1098.4397957041806, 1100.785346857355, 1101.2566517600749, 1115.1859142825783, 12054.216475929037, 12109.33398663082, 12233.632991010283, 12289.938550307192, 12320.260784352968, 240427.0, 243433.0, 244911.0, 245363.0, 245701.0, 44231.336529952074, 45233.54766452359, 51776.74111629418, 52117.69705757387, 53091.734541327045, 1505.8268299145739, 1514.2050423527517, 1514.2504460292005, 1518.3774652392467, 1519.475780855603, 27567.03515376952, 27955.16134515968, 28170.2957426066, 28239.29401764972, 28575.42849142964, 38225.23549529049, 38638.0, 38646.0, 38760.0, 38782.6121738779, 208626.0, 210419.0, 211429.0, 211543.0, 213215.0, 32864.342713146085, 33382.0, 33399.49900751442, 33410.16474588155, 33417.49873751944, 42874.57125428706, 43079.35380969351, 43167.13665726731, 43585.34621980736, 43806.0, 32482.512762309056, 32626.184345391554, 32669.836650816593, 32700.0, 32946.34107317888, 31905.0, 32073.518897216094, 32205.838970804994, 32213.677863221066, 32217.0, 35147.0, 35194.47208291826, 35276.29447410986, 35381.29237415289, 35520.644793551735, 31125.221869453446, 31345.8432707835, 31497.8425107873, 31556.36887262288, 32472.675273246965, 23153.88423057874, 23262.0695172198, 25276.494470110127, 25504.234872953843, 26545.0], "value": 17384.65471945441, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1687259206835, 590.4744777148337, 590.7223604905693, 595.7170344086562, 600.4445887554012, 22468.77531224687, 22618.66072008917, 23511.882440587793, 23555.057797688092, 23572.174973875917, 25736.227913162635, 26465.867670661668, 26710.465790684175, 26732.732672673268, 26798.196054118358, 6631.635260060695, 6791.3887750102485, 6792.18493780747, 6792.966035169818, 6816.829579260533, 6007.609505382158, 6536.869262614745, 6658.067870498134, 6745.0556922030955, 6745.763898263562, 6503.479721622259, 6508.739650413978, 6509.121268628745, 6515.609063456184, 6517.837054073639, 6486.870262594769, 6497.0, 6499.675016249169, 6502.447291980187, 6506.154199954023, 6018.247719035121, 6067.423594758491, 6067.939320606782, 6072.149899014142, 6075.2405949256345, 30031.69968300311, 30573.541396879064, 31208.21979450509, 31376.0, 31567.052988410385, 1854.0, 1906.9427917162507, 1908.4179325305777, 1908.6946088625753, 1909.035936851881, 19728.0, 20180.19279228829, 20368.898155509276, 20370.796292037187, 20478.488037799027, 2364.243442098529, 2459.397447625325, 2493.6633554470277, 2504.336350867022, 2519.0, 134967.32516337355, 137892.0, 138342.3082884589, 139218.0, 139481.0, 14286.428542858377, 14850.925745371203, 15255.847441525442, 15365.6158596036, 15396.538103856903, 23618.17336393218, 23663.408414789425, 23686.881565592063, 23710.288691339287, 23724.0, 10385.430410619454, 10603.41681207541, 10618.787624247627, 10722.0, 10878.510467029002, 10078.092971632588, 10080.899191007997, 10082.49587520621, 10238.53926573306, 10272.280940334254, 9093.727188184364, 9115.772105697279, 9306.581203845843, 9494.620215191453, 9548.283878709124, 2663.5738281874806, 2740.821846579966, 2742.890284388602, 2871.9282017949718, 2937.515309973873, 951.7858481841669, 978.3836183204678, 979.3780949097375, 989.5398639632461, 991.2961797123978, 19643.901780491007, 19701.901490492455, 19918.60162796736, 20086.799132008786, 20132.798672013094, 1020.3775696824931, 1025.661531694539, 1033.1012019543045, 1037.8495118207968, 1043.5877828257946, 11097.55609775616, 11256.831147532794, 11360.829587556193, 11366.374849383363, 11517.53929842797, 507884.0, 515067.0, 522513.0, 523796.0, 540166.0, 119172.0, 122053.0, 122228.0, 122683.0, 123313.0, 1193.6154061289037, 1213.2538488829482, 1241.3420886929941, 1249.506444954238, 1254.7741406546909, 18095.185716642518, 18139.27442902269, 18165.727514087564, 18287.725684115016, 18331.0, 57042.42957570371, 57194.7140264296, 57330.42669573251, 57752.71123644355, 58556.70721646365, 72543.63728181325, 72728.27271727215, 73084.0, 73166.63416682882, 73199.26800731925, 12342.75314493723, 12975.610731677687, 14582.0, 14843.92578037146, 15179.392824286904, 23150.652740209247, 23654.763452365256, 24070.51858962846, 24259.0, 24329.0, 18442.446726598224, 19426.12582433822, 19427.4171774847, 19443.12505937208, 19455.8054419454, 17038.74441883348, 17551.473455796346, 18365.54086147857, 18393.080345982915, 18434.26262949467, 19444.8055519443, 20230.494237643587, 20300.187992480725, 20311.4922126948, 20360.796392036482, 14936.551903442914, 14937.85062149408, 15163.09021458716, 15198.848011519744, 15213.391464341303, 18793.0, 18986.810131898503, 19021.33425330107, 19115.13981870847, 19143.90428047851], "value": 12255.17769718903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.7103237287797, 1388.021444881358, 1406.5499040307102, 1412.3997301147017, 1413.2368520998662, 13168.27574483403, 13909.582712518628, 13927.0, 13950.372233249504, 14206.928965355184, 14847.480338188165, 15190.164540950243, 15202.467913623026, 15203.695926081471, 15208.69582608347, 2665.533531631971, 2711.959320610192, 2713.579395193738, 2714.0636480414323, 2714.823536470123, 2560.0655760647414, 2622.6590543229354, 2685.78513718902, 2726.6727992640913, 2738.1511731363244, 2651.111877521033, 2680.490706765718, 2680.6515153030177, 2681.302861256068, 2683.3828219509523, 2565.576679847823, 2596.415806443554, 2600.3109176068356, 2604.843709377434, 2668.85321307328, 2531.734167912361, 2581.3804686875014, 2603.5964425514076, 2608.243609353285, 2621.829581077224, 14119.152850828881, 14179.716405671828, 14227.857721422757, 14235.572932812032, 14270.714585708332, 7818.648160832776, 8113.107558168596, 8121.675132994673, 8123.593820308961, 8127.2279133482225, 5049.772760225798, 5202.970841371868, 5245.921311180336, 5291.497307755757, 5374.172781254392, 1631.8123415807215, 1634.256413331943, 1636.1900859074715, 1662.2104500362232, 1675.3633619224738, 21397.465063373384, 21412.464688382915, 21699.240526581652, 21737.67393489099, 21764.45588860275, 6543.967280163569, 6701.195856497252, 6825.795226143224, 6864.656767161622, 6903.0, 16254.674906501803, 16281.104539250218, 16287.674246515004, 16291.0, 16311.34754609826, 7596.544207347577, 7698.0762308523335, 7748.883766743504, 7763.456558040883, 7775.028121484815, 7034.577925324497, 7084.4686648501565, 7249.166345870187, 7322.450816188807, 7336.669849856769, 4925.310456536088, 5118.923216151761, 5121.564667003347, 5144.202648589475, 5148.4851514848215, 1371.5473893615083, 1405.248192217159, 1410.3582869794218, 1425.7861320801755, 1439.2443966917451, 870.6125774030622, 882.9249513791272, 894.5571941888677, 897.2687259883305, 902.9232515236279, 7809.414293927978, 8210.137935516805, 8237.0, 8305.754136879517, 8314.584270786558, 959.2709540749081, 967.7628980899725, 971.6162115964155, 972.3776782858976, 976.7167521418709, 5667.518260947865, 5760.971195143998, 5787.739551720183, 5791.0, 5973.940260597338, 19601.31395401154, 19634.410967670992, 20228.898855505628, 20255.59488810245, 20311.28910488126, 19015.90492047531, 19278.807211927702, 19391.4182574523, 19478.0, 19514.60970780605, 10935.617253396093, 11154.442277886235, 11156.442177891073, 11174.10607151426, 11223.551057957753, 8440.649496080598, 8610.483370997761, 8754.0, 8861.778455538406, 9035.412698174598, 16791.41230056942, 17186.742198866777, 17358.739618905474, 17499.475015749547, 17538.298468061133, 16807.41174058902, 17440.47678569645, 17646.1176941155, 17905.731414028538, 18070.63858722792, 11662.650120496399, 11743.41282935867, 11763.176577639482, 11816.172867899164, 11884.881151188378, 12442.75114497723, 12532.686682832637, 12541.74916501683, 12558.560450384193, 12564.183328083645, 10540.736481587715, 10582.576696932036, 10601.893981060399, 10642.0, 10752.731181720519, 10556.031306633642, 10759.569617215537, 10775.892241077489, 10895.455227238448, 10993.61522346714, 9215.861762073708, 9483.857742134012, 9802.705918822447, 9810.411375317504, 9822.65620703272, 6920.7231710731, 6971.721131154697, 6997.1253593300835, 7043.7534686285735, 7104.893426598502, 7354.632268386452, 7370.410367170721, 7469.925300747141, 7498.512596681198, 7546.773596792105], "value": 6452.565417044462, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.37129103456544, 501.39331408995116, 526.7734874004177, 530.4721801807202, 538.717173483921, 6316.621002739833, 6337.714802833878, 6392.712327945242, 6399.336172595135, 6406.558524332035, 5965.731542080606, 6197.48161700384, 6227.346128656493, 6235.690504993957, 6252.312245652986, 4981.452040275567, 4981.850544483653, 4990.65065445419, 5042.932397716937, 5082.288479612848, 4986.700797952134, 5017.448080711119, 5025.9246111308175, 5030.471800460954, 5044.419891712463, 4771.546703063221, 4934.309196712446, 4946.356973593446, 4954.97522512387, 4955.950440495603, 4945.332380128691, 4972.95567930735, 4981.331254029904, 4990.550850423443, 5006.4743201964, 4465.330200469923, 4508.864734057984, 4511.142882852248, 4525.140223357552, 4530.932036019462, 6210.937890621081, 6230.501559875199, 6233.812985610393, 6252.843678908063, 6253.592366938761, 5663.405342439026, 5707.6290041147195, 5754.395788442237, 5779.364269930346, 5780.682062486561, 6587.374199451045, 6625.337466253336, 6642.667866606698, 6649.301823308531, 6663.268060095337, 4907.9263811042865, 4908.484609116027, 4937.160682683916, 4949.925751113737, 4955.653104282702, 7046.0, 7117.71529138839, 7137.89293160603, 7148.428125749928, 7171.713131474787, 4959.652824302264, 4978.77595508203, 5005.174146265898, 5028.2457631354855, 5057.6459647824295, 5078.111330517145, 5105.132127538327, 5109.233614957786, 5112.258722485219, 5128.0, 5738.987031808334, 5742.167385729046, 5755.366909639936, 5758.395368486333, 5778.306603207558, 6584.9012264816065, 6601.933980660228, 6617.437517810944, 6627.547807311229, 6715.664216789141, 1668.2909763350528, 1710.2133018811487, 1720.4322573550699, 1751.5533538947486, 1767.8497327727287, 1214.763121191377, 1240.5968060380412, 1246.5450110709526, 1255.8241846141548, 1263.7030297879992, 5705.2012718219485, 5755.827325180251, 5760.243125846657, 5786.508146807569, 5805.735763052413, 6638.900416493757, 6707.3292670732535, 6732.687126010381, 6760.797176084725, 6775.661216939134, 5778.711064446761, 5780.855478613068, 5802.82591522255, 5824.213731146241, 5824.359320474744, 3582.6775590197008, 3591.982040089783, 3608.314420260142, 3626.8808824410985, 3703.962890390641, 6591.209054913345, 6670.633115178712, 6701.553932814585, 6720.9663951680905, 6736.966315168491, 7090.220075791659, 7091.184513780981, 7099.574025558483, 7103.147622285359, 7106.253843346478, 6577.177852768404, 6639.336066393322, 6646.767363142363, 6677.3656502632175, 6690.5316627836555, 6868.62222577763, 6875.209350924708, 6896.172459304916, 6898.827529311607, 6917.481188910751, 6796.592204467748, 6824.454043676395, 6833.0, 6833.829154271183, 6842.521023528305, 6562.704678289584, 6569.770058047945, 6577.638229897401, 6650.800475985729, 6709.349806826373, 5464.781408743605, 5506.779728810803, 5533.557315414838, 5573.164025396223, 5581.6930068846605, 6768.424683901727, 6814.2163651180745, 6832.965835170792, 6858.177018757581, 6871.003704462725, 6626.27111017778, 6655.800325990228, 6679.131712877295, 6697.732090716317, 6701.497387695845, 6613.5370524062855, 6647.734090636321, 6651.43462805667, 6657.933420665731, 6703.698333575098, 6189.195404597373, 6363.427291543783, 6462.806115816345, 6501.674916254263, 6614.453435427491, 6639.008297510824, 6665.966670166618, 6685.598864068172, 6700.6984685688285, 6727.394534491919, 6463.7737679181, 6524.651125594687, 6528.575642583407, 6539.280679125197, 6540.182477190351], "value": 5131.481164014002, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.8741576179334, 901.058393978293, 921.7326975177199, 926.296015028579, 928.3965422475394, 19043.809561904378, 19678.11448484818, 20221.696674549894, 20238.797612023875, 20244.89877550614, 21937.890310548464, 22445.0, 22582.096716131335, 22592.20927267546, 22611.434714132156, 1029.2229366828053, 1071.3090056913286, 1071.59815069349, 1072.0137473524376, 1072.0780129088978, 1016.0550687860324, 1055.5461151704765, 1059.1156384419019, 1059.253226475337, 1059.5602824827688, 1122.0126288865786, 1131.3381671722052, 1131.490829126892, 1131.6491887514856, 1131.8075927092373, 1123.5505797680912, 1125.189863298424, 1125.499152876966, 1127.1827924754527, 1129.1305694615141, 815.1807433529324, 815.5188438821065, 815.5636734347096, 816.3958670583785, 817.2685446525386, 20227.898860505604, 20525.076371563166, 20731.585368292548, 20733.963301834847, 21040.473988150265, 22478.55042899133, 22596.32211033655, 22998.42503937415, 23158.42103947398, 23158.76841231583, 16940.491785246464, 17306.48080557585, 17312.480625581127, 17432.0, 17659.470215893543, 3388.9661103389144, 3404.4042292598697, 3413.4709120086177, 3422.178677117499, 3425.0581090200144, 123165.0, 123597.0, 123953.0, 125808.99999999908, 127401.36299318536, 17038.914805425895, 17118.14409279531, 17554.91222543879, 17684.557886052695, 17778.288868445117, 30781.84609076985, 31415.842920785708, 31457.685423145474, 32289.0, 32790.0, 7831.216878312123, 8311.16888311164, 8510.191531804468, 8758.080401557872, 9189.081091890892, 4411.558844115562, 4520.864374068783, 4529.818807247739, 4533.886652833639, 4538.160440318552, 5273.815416460482, 5307.150855863043, 5380.757865896044, 5394.190871369247, 5403.540699040547, 1067.9359238445718, 1086.9728256793485, 1098.181854518389, 1100.1199040767515, 1100.8403781451646, 547.4963034008722, 568.1477783325013, 582.0280132179271, 592.6414519215898, 599.8320470268332, 11535.0, 11645.767084658259, 11768.470418831173, 12230.021598272117, 12336.951359134395, 565.2651552981108, 566.9773209071674, 569.1519635742713, 569.6866723302168, 589.8436914217735, 5063.49365063498, 5133.794648214104, 5214.32213812202, 5351.090314646442, 5359.008583412081, 100745.49627251964, 101838.0, 102269.0, 103731.0, 108014.0, 90142.54928725315, 91243.54378228067, 91431.5428422867, 92229.0, 92897.535512322, 79568.60215699, 80339.59830200812, 80551.0, 82972.17027829644, 85224.57387713021, 10028.598856045677, 10035.69892903214, 10198.0, 10446.425446600206, 10481.580736770444, 38059.2388152241, 38258.61741382551, 38462.230755385295, 39267.41098883462, 39726.0, 46682.53317466782, 47286.290705638756, 47359.28961065656, 48166.75916620394, 48526.0, 13367.0, 13736.381862815997, 14174.220417876702, 14277.42890284377, 14308.213048282445, 19346.516337091685, 19818.801811982274, 19896.403107906786, 20054.298099566444, 20101.29645462402, 16824.0, 16934.745978810573, 16960.830391696418, 17045.744313835552, 17489.737653934946, 16838.57903552421, 16994.15029248508, 17078.402255920984, 17245.396411125552, 17300.394486192923, 16029.839701602834, 16105.275262612977, 16118.194090295672, 17909.552261193574, 18276.360327388476, 12131.878681213075, 12161.513539458323, 12391.194572352768, 12611.43248553799, 12701.36493175356, 11868.347240901834, 12627.558035468715, 12678.809817852554, 12712.6821829455, 12861.935690321488], "value": 8866.646000813404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 109.0, 107.0, 107.0, 108.0, 110.0, 99.0, 108.0, 116.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 154.0, 171.0, 120.0, 147.0, 160.0, 121.0, 177.0, 125.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 165.0, 164.0, 170.0, 171.0, 170.0, 167.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 202.0, 82.0, 75.0, 76.0, 74.0, 160.0, 75.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 130.0, 78.0, 78.0, 78.0, 126.0, 79.0, 77.0, 141.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 118.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 152.0, 151.0, 152.0, 152.0, 153.0, 153.0, 150.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 93.0, 100.0, 97.0, 101.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 55.0, 60.0, 60.0, 55.0, 57.0, 56.0, 56.0, 55.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 56.0, 59.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 91.0, 80.0, 88.0, 89.0, 79.0, 79.0, 83.0, 84.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 125.0, 136.0, 130.0, 130.0, 125.0, 125.0, 135.0, 169.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 191.0, 187.0, 178.0, 181.0, 177.0, 171.0, 171.0, 171.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 74.0, 69.0, 67.0, 65.0, 70.0, 66.0, 66.0, 66.0], "value": 68.7, "unit": "score"}]}]} 03:12:22 INFO - Return code: 0 03:12:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:12:22 INFO - # TBPL SUCCESS # 03:12:22 INFO - Running post-action listener: _package_coverage_data 03:12:22 INFO - Running post-action listener: _resource_record_post_action 03:12:22 INFO - [mozharness: 2017-08-06 10:12:22.395423Z] Finished run-tests step (success) 03:12:22 INFO - Running post-run listener: _resource_record_post_run 03:12:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 6201344; Write bytes: 440668160; Read time: 3140; Write time: 674156 03:12:22 INFO - TinderboxPrint: CPU usage
13.2% 03:12:22 INFO - TinderboxPrint: I/O read bytes / time
6,201,344 / 3,140 03:12:22 INFO - TinderboxPrint: I/O write bytes / time
440,668,160 / 674,156 03:12:22 INFO - TinderboxPrint: CPU idle
8,302.9 (86.8%) 03:12:22 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 03:12:22 INFO - TinderboxPrint: Swap in / out
0 / 0 03:12:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 146935808; Read time: 0; Write time: 200764 03:12:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:12:22 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4169728; Write bytes: 242319360; Read time: 2636; Write time: 403428 03:12:23 INFO - Running post-run listener: _upload_blobber_files 03:12:23 INFO - Blob upload gear active. 03:12:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:12:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:12:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:26 INFO - (blobuploader) - INFO - Done attempting. 03:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:12:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:26 INFO - (blobuploader) - INFO - Done attempting. 03:12:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:12:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:12:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:27 INFO - (blobuploader) - INFO - Done attempting. 03:12:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:12:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:12:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:28 INFO - (blobuploader) - INFO - Done attempting. 03:12:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:28 INFO - Return code: 0 03:12:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03b20cf37c9f4be6900de9d7265ee22da899f241952d407a7e7587b747c0bbe8ea2534b635ae769c9b58fbe2e131065777517feda533dd0213c9acb679b31968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abccab3146e082abdc07f83b57a38870db6bbe99b74f3fc7212512ab944c0e4619071fcbe0f4835b057677d8e39415eea6f91ec4283e106032d1175e2f00f1bc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8366ed5750e580990da4a05340a67915afc2ac0406f0d79e6c28dae03bae505816fff2e7c74c3f184ed404594317487d33cb350b32f5bcbb05b6ab6f44d3a742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4d72517debac9e7e2bfa5aa988761f23a0bbfcbf99de5f2dcf485d61bee1c2f70be082d8280888aab7838dad6ada12fd1805a92e67979a35949171c983fb32"} 03:12:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:28 INFO - Contents: 03:12:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03b20cf37c9f4be6900de9d7265ee22da899f241952d407a7e7587b747c0bbe8ea2534b635ae769c9b58fbe2e131065777517feda533dd0213c9acb679b31968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abccab3146e082abdc07f83b57a38870db6bbe99b74f3fc7212512ab944c0e4619071fcbe0f4835b057677d8e39415eea6f91ec4283e106032d1175e2f00f1bc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8366ed5750e580990da4a05340a67915afc2ac0406f0d79e6c28dae03bae505816fff2e7c74c3f184ed404594317487d33cb350b32f5bcbb05b6ab6f44d3a742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4d72517debac9e7e2bfa5aa988761f23a0bbfcbf99de5f2dcf485d61bee1c2f70be082d8280888aab7838dad6ada12fd1805a92e67979a35949171c983fb32"} 03:12:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:12:28 INFO - Copying logs to upload dir... 03:12:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:12:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.208513 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-06 03:12:28.302981) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:28.310611) ========= 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=eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716 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/03b20cf37c9f4be6900de9d7265ee22da899f241952d407a7e7587b747c0bbe8ea2534b635ae769c9b58fbe2e131065777517feda533dd0213c9acb679b31968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abccab3146e082abdc07f83b57a38870db6bbe99b74f3fc7212512ab944c0e4619071fcbe0f4835b057677d8e39415eea6f91ec4283e106032d1175e2f00f1bc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8366ed5750e580990da4a05340a67915afc2ac0406f0d79e6c28dae03bae505816fff2e7c74c3f184ed404594317487d33cb350b32f5bcbb05b6ab6f44d3a742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4d72517debac9e7e2bfa5aa988761f23a0bbfcbf99de5f2dcf485d61bee1c2f70be082d8280888aab7838dad6ada12fd1805a92e67979a35949171c983fb32"} build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03b20cf37c9f4be6900de9d7265ee22da899f241952d407a7e7587b747c0bbe8ea2534b635ae769c9b58fbe2e131065777517feda533dd0213c9acb679b31968", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abccab3146e082abdc07f83b57a38870db6bbe99b74f3fc7212512ab944c0e4619071fcbe0f4835b057677d8e39415eea6f91ec4283e106032d1175e2f00f1bc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8366ed5750e580990da4a05340a67915afc2ac0406f0d79e6c28dae03bae505816fff2e7c74c3f184ed404594317487d33cb350b32f5bcbb05b6ab6f44d3a742", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8b4d72517debac9e7e2bfa5aa988761f23a0bbfcbf99de5f2dcf485d61bee1c2f70be082d8280888aab7838dad6ada12fd1805a92e67979a35949171c983fb32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:28.337925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:28.338253) ========= 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=eca2ab57546de7b41f256b19000001ef-1502002627.973749-1647937716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:28.417865) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:12:28.418165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:12:28.421451) ========= ========= Total master_lag: 0.19 =========