builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1498479043.99 results: success (0) revision: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:43.990091) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:43.990485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:43.990761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:44.027988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:44.028313) ========= 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=836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-26 05:10:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.2M=0s 2017-06-26 05:10:44 (87.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.235396 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:44.298349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:44.302042) ========= 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=836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.081632 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:44.398749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-26 05:10:44.399101) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev af9a8cebd43fb23822be25c5d4d065d5e9e195b8 --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 af9a8cebd43fb23822be25c5d4d065d5e9e195b8 --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=836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-26 05:10:44,581 truncating revision to first 12 chars 2017-06-26 05:10:44,581 Setting DEBUG logging. 2017-06-26 05:10:44,581 attempt 1/10 2017-06-26 05:10:44,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/af9a8cebd43f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-26 05:10:46,092 unpacking tar archive at: mozilla-central-af9a8cebd43f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.881845 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-26 05:10:46.295934) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:46.299610) ========= script_repo_revision: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:46.299987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:46.300248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-26 05:10:46.309620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-06-26 05:10:46.309886) ========= /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=836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:46 INFO - MultiFileLogger online at 20170626 05:10:46 in /builds/slave/test 05:10:46 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 05:10:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:46 INFO - {'append_to_log': False, 05:10:46 INFO - 'base_work_dir': '/builds/slave/test', 05:10:46 INFO - 'blob_upload_branch': 'Firefox', 05:10:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:46 INFO - 'branch': 'Firefox', 05:10:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:46 INFO - 'config_files': ('talos/linux_config.py',), 05:10:46 INFO - 'default_actions': ('clobber', 05:10:46 INFO - 'read-buildbot-config', 05:10:46 INFO - 'download-and-extract', 05:10:46 INFO - 'populate-webroot', 05:10:46 INFO - 'create-virtualenv', 05:10:46 INFO - 'install', 05:10:46 INFO - 'setup-mitmproxy', 05:10:46 INFO - 'run-tests'), 05:10:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:46 INFO - 'download_minidump_stackwalk': True, 05:10:46 INFO - 'download_symbols': 'ondemand', 05:10:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:46 INFO - 'gecko_profile': False, 05:10:46 INFO - 'gecko_profile_interval': 0, 05:10:46 INFO - 'installer_path': 'installer.exe', 05:10:46 INFO - 'log_level': 'info', 05:10:46 INFO - 'log_name': 'talos', 05:10:46 INFO - 'log_to_console': True, 05:10:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:46 INFO - 'opt_config_files': (), 05:10:46 INFO - 'pip_index': False, 05:10:46 INFO - 'suite': 'dromaeojs-e10s', 05:10:46 INFO - 'system_bits': '32', 05:10:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:46 INFO - 'title': 'talos-linux64-ix-028', 05:10:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:46 INFO - 'use_talos_json': True, 05:10:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:46 INFO - 'work_dir': 'build'} 05:10:46 INFO - [mozharness: 2017-06-26 12:10:46.720268Z] Running clobber step. 05:10:46 INFO - Running pre-action listener: _resource_record_pre_action 05:10:46 INFO - Running main action method: clobber 05:10:46 INFO - rmtree: /builds/slave/test/build 05:10:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:52 INFO - Running post-action listener: _resource_record_post_action 05:10:52 INFO - [mozharness: 2017-06-26 12:10:52.378914Z] Finished clobber step (success) 05:10:52 INFO - [mozharness: 2017-06-26 12:10:52.379114Z] Running read-buildbot-config step. 05:10:52 INFO - Running pre-action listener: _resource_record_pre_action 05:10:52 INFO - Running main action method: read_buildbot_config 05:10:52 INFO - Using buildbot properties: 05:10:52 INFO - { 05:10:52 INFO - "project": "", 05:10:52 INFO - "product": "firefox", 05:10:52 INFO - "who": "cbook@mozilla.com", 05:10:52 INFO - "installer_path": "public/build/target.tar.bz2", 05:10:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:10:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:10:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:10:52 INFO - "stage_platform": "linux64-stylosequential", 05:10:52 INFO - "basedir": "/builds/slave/test", 05:10:52 INFO - "buildnumber": 72, 05:10:52 INFO - "platform": "ubuntu64_hw_styloseq", 05:10:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:10:52 INFO - "slavebuilddir": "test", 05:10:52 INFO - "taskId": "GZworH1CQnuheleAeDmTQg", 05:10:52 INFO - "branch": "mozilla-central", 05:10:52 INFO - "script_repo_revision": "production", 05:10:52 INFO - "revision": "af9a8cebd43fb23822be25c5d4d065d5e9e195b8", 05:10:52 INFO - "slavename": "talos-linux64-ix-028", 05:10:52 INFO - "repo_path": "mozilla-central" 05:10:52 INFO - } 05:10:52 INFO - Finding installer, test and symbols from parent task. 05:10:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GZworH1CQnuheleAeDmTQg'}, attempt #1 05:10:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GZworH1CQnuheleAeDmTQg'}, attempt #1 05:10:53 INFO - Task dependencies: KYnvssSNQEev-CA0uoM8ww 05:10:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww'}, attempt #1 05:10:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2 05:10:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/test_packages.json 05:10:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.crashreporter-symbols.zip 05:10:53 INFO - Running post-action listener: _resource_record_post_action 05:10:53 INFO - [mozharness: 2017-06-26 12:10:53.866044Z] Finished read-buildbot-config step (success) 05:10:53 INFO - [mozharness: 2017-06-26 12:10:53.866262Z] Running download-and-extract step. 05:10:53 INFO - Running pre-action listener: _resource_record_pre_action 05:10:53 INFO - Running main action method: download_and_extract 05:10:53 INFO - mkdir: /builds/slave/test/build/tests 05:10:53 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')]} 05:10:53 INFO - trying https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.test_packages.json 05:10:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:10:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:10:54 INFO - Downloaded 989 bytes. 05:10:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:10:54 INFO - Using the following test package requirements: 05:10:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:10:54 INFO - u'common': [u'target.common.tests.zip'], 05:10:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:10:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:10:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:10:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:10:54 INFO - u'mozbase': [u'target.common.tests.zip'], 05:10:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:10:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:10:54 INFO - u'web-platform': [u'target.common.tests.zip', 05:10:54 INFO - u'target.web-platform.tests.tar.gz'], 05:10:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:10:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:10:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.common.tests.zip 05:10:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:10:54 INFO - Fetch https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.common.tests.zip into memory 05:10:55 INFO - Content-Length response header: 67759228 05:10:55 INFO - Bytes received: 67759228 05:11:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:11:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.common.tests.zip 05:11:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:11:06 INFO - Fetch https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.common.tests.zip into memory 05:11:07 INFO - Content-Length response header: 67759228 05:11:07 INFO - Bytes received: 67759228 05:11:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.talos.tests.zip 05:11:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:11:20 INFO - Fetch https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.talos.tests.zip into memory 05:11:21 INFO - Content-Length response header: 14441319 05:11:21 INFO - Bytes received: 14441319 05:11: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')]} 05:11:21 INFO - trying https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2 05:11:21 INFO - Downloading https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:11:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:11:22 INFO - Downloaded 61779810 bytes. 05:11:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2 05:11:22 INFO - mkdir: /builds/slave/test/properties 05:11:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:22 INFO - Contents: 05:11:22 INFO - build_url:https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2 05:11:22 INFO - Running post-action listener: _resource_record_post_action 05:11:22 INFO - Running post-action listener: set_extra_try_arguments 05:11:22 INFO - [mozharness: 2017-06-26 12:11:22.502329Z] Finished download-and-extract step (success) 05:11:22 INFO - [mozharness: 2017-06-26 12:11:22.502424Z] Running populate-webroot step. 05:11:22 INFO - Running pre-action listener: _resource_record_pre_action 05:11:22 INFO - Running main action method: populate_webroot 05:11:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:22 INFO - '--tppagecycles', 05:11:22 INFO - '7'], 05:11:22 INFO - 'tests': ['tsvgm']}}, 05:11:22 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['damp', 'tps']}, 05:11:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'tests': ['damp', 'tps']}, 05:11:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['dromaeo_dom']}, 05:11:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:11:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:11:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:11:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['a11yr', 05:11:22 INFO - 'ts_paint', 05:11:22 INFO - 'tpaint', 05:11:22 INFO - 'sessionrestore', 05:11:22 INFO - 'sessionrestore_no_auto_restore', 05:11:22 INFO - 'tabpaint']}, 05:11:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:22 INFO - 'ts_paint', 05:11:22 INFO - 'tpaint', 05:11:22 INFO - 'sessionrestore', 05:11:22 INFO - 'sessionrestore_no_auto_restore', 05:11:22 INFO - 'tabpaint']}, 05:11:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:22 INFO - 'ts_paint', 05:11:22 INFO - 'tpaint', 05:11:22 INFO - 'sessionrestore', 05:11:22 INFO - 'sessionrestore_no_auto_restore', 05:11:22 INFO - 'tabpaint']}, 05:11:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:22 INFO - 'ts_paint', 05:11:22 INFO - 'tpaint', 05:11:22 INFO - 'sessionrestore', 05:11:22 INFO - 'sessionrestore_no_auto_restore', 05:11:22 INFO - 'tabpaint']}, 05:11:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['a11yr', 05:11:22 INFO - 'ts_paint', 05:11:22 INFO - 'tpaint', 05:11:22 INFO - 'sessionrestore', 05:11:22 INFO - 'sessionrestore_no_auto_restore', 05:11:22 INFO - 'tabpaint']}, 05:11:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['a11yr', 05:11:22 INFO - 'ts_paint', 05:11:22 INFO - 'tpaint', 05:11:22 INFO - 'sessionrestore', 05:11:22 INFO - 'sessionrestore_no_auto_restore', 05:11:22 INFO - 'tabpaint']}, 05:11:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:11:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:11:22 INFO - 'bloom_basic_ref']}, 05:11:22 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:11:22 INFO - 'talos_options': ['--mitmproxy', 05:11:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:11:22 INFO - '--firstNonBlankPaint'], 05:11:22 INFO - 'tests': ['quantum_pageload_google', 05:11:22 INFO - 'quantum_pageload_youtube', 05:11:22 INFO - 'quantum_pageload_amazon', 05:11:22 INFO - 'quantum_pageload_facebook']}, 05:11:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['tsvgx', 05:11:22 INFO - 'tsvgr_opacity', 05:11:22 INFO - 'tart', 05:11:22 INFO - 'tscrollx', 05:11:22 INFO - 'cart', 05:11:22 INFO - 'tsvg_static']}, 05:11:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:22 INFO - 'tsvgr_opacity', 05:11:22 INFO - 'tart', 05:11:22 INFO - 'tscrollx', 05:11:22 INFO - 'cart', 05:11:22 INFO - 'tsvg_static']}, 05:11:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'talos_options': ['--disable-e10s'], 05:11:22 INFO - 'tests': ['tp5o']}, 05:11:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:11:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'talos_options': ['--disable-e10s', 05:11:22 INFO - '--xperf_path', 05:11:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:22 INFO - 'tests': ['tp5n']}, 05:11:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:11:22 INFO - 'talos_options': ['--xperf_path', 05:11:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:22 INFO - 'tests': ['tp5n']}}, 05:11:22 INFO - 'talos.zip': {'path': '', 05:11:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:22 INFO - Running post-action listener: _resource_record_post_action 05:11:22 INFO - [mozharness: 2017-06-26 12:11:22.517266Z] Finished populate-webroot step (success) 05:11:22 INFO - [mozharness: 2017-06-26 12:11:22.517368Z] Running create-virtualenv step. 05:11:22 INFO - Running pre-action listener: _resource_record_pre_action 05:11:22 INFO - Running main action method: create_virtualenv 05:11:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:22 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 05:11:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:11:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:22 INFO - Using real prefix '/usr' 05:11:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:25 INFO - Installing pip.................done. 05:11:25 INFO - Return code: 0 05:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:25 INFO - Reading from file tmpfile_stdout 05:11:25 INFO - Output received: 05:11:25 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) 05:11:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:25 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')]} 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:25 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')]} 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:25 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:25 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 05:11:25 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 05:11:25 INFO - Using env: {'DISPLAY': ':0', 05:11:25 INFO - 'HOME': '/home/cltbld', 05:11:25 INFO - 'LANG': 'en_US.UTF-8', 05:11:25 INFO - 'LANGUAGE': 'en_US:en', 05:11:25 INFO - 'LOGNAME': 'cltbld', 05:11:25 INFO - 'MAIL': '/var/mail/cltbld', 05:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:25 INFO - 'MOZ_NO_REMOTE': '1', 05:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:25 INFO - 'NO_EM_RESTART': '1', 05:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:25 INFO - 'PWD': '/builds/slave/test', 05:11:25 INFO - 'SHELL': '/bin/bash', 05:11:25 INFO - 'SHLVL': '1', 05:11:25 INFO - 'TERM': 'linux', 05:11:25 INFO - 'TMOUT': '86400', 05:11:25 INFO - 'USER': 'cltbld', 05:11:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:25 INFO - '_': '/tools/buildbot/bin/python'} 05:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:25 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 05:11:25 INFO - Cleaning up... 05:11:25 INFO - Return code: 0 05:11:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11:25 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')]} 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:25 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')]} 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:25 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:25 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 05:11:25 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 05:11:25 INFO - Using env: {'DISPLAY': ':0', 05:11:25 INFO - 'HOME': '/home/cltbld', 05:11:25 INFO - 'LANG': 'en_US.UTF-8', 05:11:25 INFO - 'LANGUAGE': 'en_US:en', 05:11:25 INFO - 'LOGNAME': 'cltbld', 05:11:25 INFO - 'MAIL': '/var/mail/cltbld', 05:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:25 INFO - 'MOZ_NO_REMOTE': '1', 05:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:25 INFO - 'NO_EM_RESTART': '1', 05:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:25 INFO - 'PWD': '/builds/slave/test', 05:11:25 INFO - 'SHELL': '/bin/bash', 05:11:25 INFO - 'SHLVL': '1', 05:11:25 INFO - 'TERM': 'linux', 05:11:25 INFO - 'TMOUT': '86400', 05:11:25 INFO - 'USER': 'cltbld', 05:11:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:25 INFO - '_': '/tools/buildbot/bin/python'} 05:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:25 INFO - Downloading/unpacking psutil>=3.1.1 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:27 INFO - Installing collected packages: psutil 05:11:27 INFO - Running setup.py install for psutil 05:11:27 INFO - building 'psutil._psutil_linux' extension 05:11:27 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 05:11:28 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 05:11:28 INFO - building 'psutil._psutil_posix' extension 05:11:28 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 05:11:28 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 05:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:28 INFO - Successfully installed psutil 05:11:28 INFO - Cleaning up... 05:11:28 INFO - Return code: 0 05:11:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:28 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')]} 05:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:28 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')]} 05:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:28 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:28 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 05:11:28 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 05:11:28 INFO - Using env: {'DISPLAY': ':0', 05:11:28 INFO - 'HOME': '/home/cltbld', 05:11:28 INFO - 'LANG': 'en_US.UTF-8', 05:11:28 INFO - 'LANGUAGE': 'en_US:en', 05:11:28 INFO - 'LOGNAME': 'cltbld', 05:11:28 INFO - 'MAIL': '/var/mail/cltbld', 05:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:28 INFO - 'MOZ_NO_REMOTE': '1', 05:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:28 INFO - 'NO_EM_RESTART': '1', 05:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:28 INFO - 'PWD': '/builds/slave/test', 05:11:28 INFO - 'SHELL': '/bin/bash', 05:11:28 INFO - 'SHLVL': '1', 05:11:28 INFO - 'TERM': 'linux', 05:11:28 INFO - 'TMOUT': '86400', 05:11:28 INFO - 'USER': 'cltbld', 05:11:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:28 INFO - '_': '/tools/buildbot/bin/python'} 05:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:28 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 05:11:28 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 05:11:28 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 05:11:28 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 05:11:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:30 INFO - Installing collected packages: mozsystemmonitor 05:11:30 INFO - Running setup.py install for mozsystemmonitor 05:11:30 INFO - Successfully installed mozsystemmonitor 05:11:30 INFO - Cleaning up... 05:11:30 INFO - Return code: 0 05:11:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:30 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')]} 05:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:30 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')]} 05:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:30 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:30 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 05:11:30 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 05:11:30 INFO - Using env: {'DISPLAY': ':0', 05:11:30 INFO - 'HOME': '/home/cltbld', 05:11:30 INFO - 'LANG': 'en_US.UTF-8', 05:11:30 INFO - 'LANGUAGE': 'en_US:en', 05:11:30 INFO - 'LOGNAME': 'cltbld', 05:11:30 INFO - 'MAIL': '/var/mail/cltbld', 05:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:30 INFO - 'MOZ_NO_REMOTE': '1', 05:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:30 INFO - 'NO_EM_RESTART': '1', 05:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:30 INFO - 'PWD': '/builds/slave/test', 05:11:30 INFO - 'SHELL': '/bin/bash', 05:11:30 INFO - 'SHLVL': '1', 05:11:30 INFO - 'TERM': 'linux', 05:11:30 INFO - 'TMOUT': '86400', 05:11:30 INFO - 'USER': 'cltbld', 05:11:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:30 INFO - '_': '/tools/buildbot/bin/python'} 05:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:30 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:30 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 05:11:30 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 05:11:30 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 05:11:30 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 05:11:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:31 INFO - warning: no files found matching '*.txt' 05:11:31 INFO - no previously-included directories found matching 'build' 05:11:31 INFO - no previously-included directories found matching 'dist' 05:11:31 INFO - no previously-included directories found matching '.git*' 05:11:31 INFO - Installing collected packages: jsonschema, functools32 05:11:31 INFO - Running setup.py install for functools32 05:11:31 INFO - warning: no files found matching '*.txt' 05:11:31 INFO - no previously-included directories found matching 'build' 05:11:31 INFO - no previously-included directories found matching 'dist' 05:11:31 INFO - no previously-included directories found matching '.git*' 05:11:31 INFO - Successfully installed jsonschema functools32 05:11:31 INFO - Cleaning up... 05:11:31 INFO - Return code: 0 05:11:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:11:31 INFO - Using env: {'DISPLAY': ':0', 05:11:31 INFO - 'HOME': '/home/cltbld', 05:11:31 INFO - 'LANG': 'en_US.UTF-8', 05:11:31 INFO - 'LANGUAGE': 'en_US:en', 05:11:31 INFO - 'LOGNAME': 'cltbld', 05:11:31 INFO - 'MAIL': '/var/mail/cltbld', 05:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:31 INFO - 'MOZ_NO_REMOTE': '1', 05:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:31 INFO - 'NO_EM_RESTART': '1', 05:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:31 INFO - 'PWD': '/builds/slave/test', 05:11:31 INFO - 'SHELL': '/bin/bash', 05:11:31 INFO - 'SHLVL': '1', 05:11:31 INFO - 'TERM': 'linux', 05:11:31 INFO - 'TMOUT': '86400', 05:11:31 INFO - 'USER': 'cltbld', 05:11:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:31 INFO - '_': '/tools/buildbot/bin/python'} 05:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:11:32 INFO - Cleaning up... 05:11:32 INFO - Return code: 0 05:11:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:32 INFO - Using env: {'DISPLAY': ':0', 05:11:32 INFO - 'HOME': '/home/cltbld', 05:11:32 INFO - 'LANG': 'en_US.UTF-8', 05:11:32 INFO - 'LANGUAGE': 'en_US:en', 05:11:32 INFO - 'LOGNAME': 'cltbld', 05:11:32 INFO - 'MAIL': '/var/mail/cltbld', 05:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:32 INFO - 'MOZ_NO_REMOTE': '1', 05:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:32 INFO - 'NO_EM_RESTART': '1', 05:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:32 INFO - 'PWD': '/builds/slave/test', 05:11:32 INFO - 'SHELL': '/bin/bash', 05:11:32 INFO - 'SHLVL': '1', 05:11:32 INFO - 'TERM': 'linux', 05:11:32 INFO - 'TMOUT': '86400', 05:11:32 INFO - 'USER': 'cltbld', 05:11:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:32 INFO - '_': '/tools/buildbot/bin/python'} 05:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:33 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 05:11:33 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 05:11:33 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 05:11:33 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 05:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:33 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 05:11:33 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 05:11:33 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 05:11:33 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 05:11:33 INFO - Downloading docopt-0.6.1.tar.gz 05:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:34 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:34 INFO - Running setup.py install for blobuploader 05:11:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:34 INFO - Running setup.py install for requests 05:11:34 INFO - Running setup.py install for docopt 05:11:34 INFO - Successfully installed blobuploader requests docopt 05:11:34 INFO - Cleaning up... 05:11:34 INFO - Return code: 0 05:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:34 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:34 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 05:11:34 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 05:11:34 INFO - Using env: {'DISPLAY': ':0', 05:11:34 INFO - 'HOME': '/home/cltbld', 05:11:34 INFO - 'LANG': 'en_US.UTF-8', 05:11:34 INFO - 'LANGUAGE': 'en_US:en', 05:11:34 INFO - 'LOGNAME': 'cltbld', 05:11:34 INFO - 'MAIL': '/var/mail/cltbld', 05:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:34 INFO - 'MOZ_NO_REMOTE': '1', 05:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:34 INFO - 'NO_EM_RESTART': '1', 05:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:34 INFO - 'PWD': '/builds/slave/test', 05:11:34 INFO - 'SHELL': '/bin/bash', 05:11:34 INFO - 'SHLVL': '1', 05:11:34 INFO - 'TERM': 'linux', 05:11:34 INFO - 'TMOUT': '86400', 05:11:34 INFO - 'USER': 'cltbld', 05:11:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:34 INFO - '_': '/tools/buildbot/bin/python'} 05:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:34 INFO - Running setup.py (path:/tmp/pip-FDmrn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:34 INFO - Running setup.py (path:/tmp/pip-y2Lkoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:34 INFO - Running setup.py (path:/tmp/pip-h1ueDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:35 INFO - Running setup.py (path:/tmp/pip-Ec5ZSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:35 INFO - Running setup.py (path:/tmp/pip-mhqEga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:35 INFO - Running setup.py (path:/tmp/pip-WRGidU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:35 INFO - Running setup.py (path:/tmp/pip-Ji7Sda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:35 INFO - Running setup.py (path:/tmp/pip-0Ssjg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:35 INFO - Running setup.py (path:/tmp/pip-hIEUyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:35 INFO - Running setup.py (path:/tmp/pip-2EVMHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:35 INFO - Running setup.py (path:/tmp/pip-w_vwoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:35 INFO - Running setup.py (path:/tmp/pip-nADXZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:35 INFO - Running setup.py (path:/tmp/pip-IoLn6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:35 INFO - Running setup.py (path:/tmp/pip-I3WY0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:35 INFO - Running setup.py (path:/tmp/pip-IyqSnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:35 INFO - Running setup.py (path:/tmp/pip-roemkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:35 INFO - Running setup.py (path:/tmp/pip-uMyqgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:36 INFO - Running setup.py install for manifestparser 05:11:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Running setup.py install for mozcrash 05:11:36 INFO - Running setup.py install for mozdebug 05:11:36 INFO - Running setup.py install for mozdevice 05:11:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Running setup.py install for mozfile 05:11:36 INFO - Running setup.py install for mozhttpd 05:11:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Running setup.py install for mozinfo 05:11:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Running setup.py install for mozInstall 05:11:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:36 INFO - Running setup.py install for mozleak 05:11:36 INFO - Running setup.py install for mozlog 05:11:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Running setup.py install for moznetwork 05:11:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Running setup.py install for mozprocess 05:11:37 INFO - Running setup.py install for mozprofile 05:11:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Running setup.py install for mozrunner 05:11:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Running setup.py install for mozscreenshot 05:11:37 INFO - Running setup.py install for moztest 05:11:37 INFO - Running setup.py install for mozversion 05:11:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:37 INFO - Cleaning up... 05:11:37 INFO - Return code: 0 05:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:37 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:37 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 05:11:37 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 05:11:37 INFO - Using env: {'DISPLAY': ':0', 05:11:37 INFO - 'HOME': '/home/cltbld', 05:11:37 INFO - 'LANG': 'en_US.UTF-8', 05:11:37 INFO - 'LANGUAGE': 'en_US:en', 05:11:37 INFO - 'LOGNAME': 'cltbld', 05:11:37 INFO - 'MAIL': '/var/mail/cltbld', 05:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:37 INFO - 'MOZ_NO_REMOTE': '1', 05:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:37 INFO - 'NO_EM_RESTART': '1', 05:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:37 INFO - 'PWD': '/builds/slave/test', 05:11:37 INFO - 'SHELL': '/bin/bash', 05:11:37 INFO - 'SHLVL': '1', 05:11:37 INFO - 'TERM': 'linux', 05:11:37 INFO - 'TMOUT': '86400', 05:11:37 INFO - 'USER': 'cltbld', 05:11:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:37 INFO - '_': '/tools/buildbot/bin/python'} 05:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:38 INFO - Running setup.py (path:/tmp/pip-INNIJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:38 INFO - Running setup.py (path:/tmp/pip-s6eV1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:38 INFO - Running setup.py (path:/tmp/pip-av7zr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:38 INFO - Running setup.py (path:/tmp/pip-S_Jjw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:38 INFO - Running setup.py (path:/tmp/pip-3CkA68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:38 INFO - Running setup.py (path:/tmp/pip-BU2tE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:38 INFO - Running setup.py (path:/tmp/pip-xBIAZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:38 INFO - Running setup.py (path:/tmp/pip-ojGEAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:38 INFO - Running setup.py (path:/tmp/pip-Kyhchi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:38 INFO - Running setup.py (path:/tmp/pip-b4Nq3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:38 INFO - Running setup.py (path:/tmp/pip-HcFsbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:38 INFO - Running setup.py (path:/tmp/pip-jeGwlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:38 INFO - Running setup.py (path:/tmp/pip-t5TxfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:38 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)) 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:38 INFO - Running setup.py (path:/tmp/pip-4Mh2hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:39 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)) 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:39 INFO - Running setup.py (path:/tmp/pip-fTg5uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:39 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)) 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:39 INFO - Running setup.py (path:/tmp/pip-8Ftcbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:39 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)) 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:39 INFO - Running setup.py (path:/tmp/pip-_kZlu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 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)) 05:11:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:40 INFO - Downloading blessings-1.6.tar.gz 05:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:40 INFO - Installing collected packages: blessings 05:11:40 INFO - Running setup.py install for blessings 05:11:40 INFO - Successfully installed blessings 05:11:40 INFO - Cleaning up... 05:11:40 INFO - Return code: 0 05:11:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:40 INFO - Reading from file tmpfile_stdout 05:11:40 INFO - Current package versions: 05:11:40 INFO - argparse == 1.2.1 05:11:40 INFO - blessings == 1.6 05:11:40 INFO - blobuploader == 1.2.4 05:11:40 INFO - docopt == 0.6.1 05:11:40 INFO - functools32 == 3.2.3-2 05:11:40 INFO - jsonschema == 2.5.1 05:11:40 INFO - manifestparser == 1.1 05:11:40 INFO - mozInstall == 1.13 05:11:40 INFO - mozcrash == 1.0 05:11:40 INFO - mozdebug == 0.1 05:11:40 INFO - mozdevice == 0.51 05:11:40 INFO - mozfile == 1.2 05:11:40 INFO - mozhttpd == 0.7 05:11:40 INFO - mozinfo == 0.10 05:11:40 INFO - mozleak == 0.1 05:11:40 INFO - mozlog == 3.4 05:11:40 INFO - moznetwork == 0.27 05:11:40 INFO - mozprocess == 0.25 05:11:40 INFO - mozprofile == 0.28 05:11:40 INFO - mozrunner == 6.13 05:11:40 INFO - mozscreenshot == 0.1 05:11:40 INFO - mozsystemmonitor == 0.3 05:11:40 INFO - moztest == 0.8 05:11:40 INFO - mozversion == 1.4 05:11:40 INFO - psutil == 3.1.1 05:11:40 INFO - requests == 1.2.3 05:11:40 INFO - wsgiref == 0.1.2 05:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11: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')]} 05:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:40 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:40 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 05:11:40 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 05:11:40 INFO - Using env: {'DISPLAY': ':0', 05:11:40 INFO - 'HOME': '/home/cltbld', 05:11:40 INFO - 'LANG': 'en_US.UTF-8', 05:11:40 INFO - 'LANGUAGE': 'en_US:en', 05:11:40 INFO - 'LOGNAME': 'cltbld', 05:11:40 INFO - 'MAIL': '/var/mail/cltbld', 05:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:40 INFO - 'MOZ_NO_REMOTE': '1', 05:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:40 INFO - 'NO_EM_RESTART': '1', 05:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:40 INFO - 'PWD': '/builds/slave/test', 05:11:40 INFO - 'SHELL': '/bin/bash', 05:11:40 INFO - 'SHLVL': '1', 05:11:40 INFO - 'TERM': 'linux', 05:11:40 INFO - 'TMOUT': '86400', 05:11:40 INFO - 'USER': 'cltbld', 05:11:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:40 INFO - '_': '/tools/buildbot/bin/python'} 05:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 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)) 05:11:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:11:41 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 05:11:41 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 05:11:41 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 05:11:41 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 05:11:42 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:11:42 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)) 05:11:42 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)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:11:42 INFO - Installing collected packages: marionette-driver 05:11:42 INFO - Running setup.py install for marionette-driver 05:11:42 INFO - Successfully installed marionette-driver 05:11:42 INFO - Cleaning up... 05:11:42 INFO - Return code: 0 05:11:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:42 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 0xe543b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, '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': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', '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 05:11:42 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 05:11:42 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 05:11:42 INFO - Using env: {'DISPLAY': ':0', 05:11:42 INFO - 'HOME': '/home/cltbld', 05:11:42 INFO - 'LANG': 'en_US.UTF-8', 05:11:42 INFO - 'LANGUAGE': 'en_US:en', 05:11:42 INFO - 'LOGNAME': 'cltbld', 05:11:42 INFO - 'MAIL': '/var/mail/cltbld', 05:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:42 INFO - 'MOZ_NO_REMOTE': '1', 05:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:42 INFO - 'NO_EM_RESTART': '1', 05:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:42 INFO - 'PWD': '/builds/slave/test', 05:11:42 INFO - 'SHELL': '/bin/bash', 05:11:42 INFO - 'SHLVL': '1', 05:11:42 INFO - 'TERM': 'linux', 05:11:42 INFO - 'TMOUT': '86400', 05:11:42 INFO - 'USER': 'cltbld', 05:11:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:42 INFO - '_': '/tools/buildbot/bin/python'} 05:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:42 INFO - Cleaning up... 05:11:42 INFO - Return code: 0 05:11:42 INFO - Running post-action listener: _resource_record_post_action 05:11:42 INFO - Running post-action listener: _start_resource_monitoring 05:11:42 INFO - Starting resource monitoring. 05:11:42 INFO - [mozharness: 2017-06-26 12:11:42.604923Z] Finished create-virtualenv step (success) 05:11:42 INFO - [mozharness: 2017-06-26 12:11:42.605424Z] Running install step. 05:11:42 INFO - Running pre-action listener: _resource_record_pre_action 05:11:42 INFO - Running main action method: install 05:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:42 INFO - Reading from file tmpfile_stdout 05:11:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:42 INFO - Reading from file tmpfile_stdout 05:11:42 INFO - Output received: 05:11:42 INFO - Usage: mozinstall [options] installer 05:11:42 INFO - Options: 05:11:42 INFO - -h, --help show this help message and exit 05:11:42 INFO - -d DEST, --destination=DEST 05:11:42 INFO - Directory to install application into. [default: 05:11:42 INFO - "/builds/slave/test"] 05:11:42 INFO - --app=APP Application being installed. [default: firefox] 05:11:42 INFO - mkdir: /builds/slave/test/build/application 05:11:42 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'] 05:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:12:00 INFO - Reading from file tmpfile_stdout 05:12:00 INFO - Output received: 05:12:00 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:00 INFO - Running post-action listener: _resource_record_post_action 05:12:00 INFO - [mozharness: 2017-06-26 12:12:00.880152Z] Finished install step (success) 05:12:00 INFO - [mozharness: 2017-06-26 12:12:00.880429Z] Running setup-mitmproxy step. 05:12:00 INFO - Running pre-action listener: _resource_record_pre_action 05:12:00 INFO - Running main action method: setup_mitmproxy 05:12:00 INFO - Skipping: mitmproxy is not required 05:12:00 INFO - Running post-action listener: _resource_record_post_action 05:12:00 INFO - [mozharness: 2017-06-26 12:12:00.881702Z] Finished setup-mitmproxy step (success) 05:12:00 INFO - [mozharness: 2017-06-26 12:12:00.881926Z] Running run-tests step. 05:12:00 INFO - Running pre-action listener: _resource_record_pre_action 05:12:00 INFO - Running main action method: run_tests 05:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:00 INFO - Python 2.7.3 05:12:00 INFO - Return code: 0 05:12:00 INFO - grabbing minidump binary from tooltool 05:12:00 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')]} 05:12:00 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 0x11d0140>, '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 0x11d0a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d0ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:00 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 05:12:00 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 05:12:00 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 05:12:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:01 INFO - Return code: 0 05:12:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:01 INFO - ENV: RUST_BACKTRACE is now 1 05:12:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:01 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/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:12:01 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/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 05:12:01 INFO - Using env: {'DISPLAY': ':0', 05:12:01 INFO - 'HOME': '/home/cltbld', 05:12:01 INFO - 'LANG': 'en_US.UTF-8', 05:12:01 INFO - 'LANGUAGE': 'en_US:en', 05:12:01 INFO - 'LOGNAME': 'cltbld', 05:12:01 INFO - 'MAIL': '/var/mail/cltbld', 05:12:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:01 INFO - 'MOZ_NO_REMOTE': '1', 05:12:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:01 INFO - 'NO_EM_RESTART': '1', 05:12:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:01 INFO - 'PWD': '/builds/slave/test', 05:12:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:01 INFO - 'RUST_BACKTRACE': '1', 05:12:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:12:01 INFO - 'SHELL': '/bin/bash', 05:12:01 INFO - 'SHLVL': '1', 05:12:01 INFO - 'TERM': 'linux', 05:12:01 INFO - 'TMOUT': '86400', 05:12:01 INFO - 'USER': 'cltbld', 05:12:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977', 05:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:01 INFO - '_': '/tools/buildbot/bin/python'} 05:12:01 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/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 05:12:01 INFO - mozversion application_buildid: 20170626112703 05:12:01 INFO - mozversion application_changeset: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 05:12:01 INFO - mozversion application_display_name: Nightly 05:12:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:01 INFO - mozversion application_name: Firefox 05:12:01 INFO - mozversion application_remotingname: firefox 05:12:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:12:01 INFO - mozversion application_vendor: Mozilla 05:12:01 INFO - mozversion application_version: 56.0a1 05:12:01 INFO - mozversion platform_buildid: 20170626112703 05:12:01 INFO - mozversion platform_changeset: af9a8cebd43fb23822be25c5d4d065d5e9e195b8 05:12:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:12:01 INFO - mozversion platform_version: 56.0a1 05:12:01 INFO - using testdate: 1498479121 05:12:01 INFO - actual date: 1498479121 05:12:01 INFO - starting webserver on 'localhost:53152' 05:12:01 INFO - SUITE-START | Running 2 tests 05:12:01 INFO - TEST-START | dromaeo_css 05:12:01 INFO - operating with platform_type : linux_ 05:12:01 INFO - Initialising browser for dromaeo_css test... 05:12:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53152/getInfo.html -profile /tmp/tmpl_zsTN/profile 05:12:01 INFO - TEST-INFO | started process 3398 (/builds/slave/test/build/application/firefox/firefox http://localhost:53152/getInfo.html) 05:12:10 INFO - TEST-INFO | 3398: exit 0 05:12:10 INFO - Browser initialized. 05:12:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:10 INFO - TEST-INFO | started process 3623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl_zsTN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:22 INFO - PID 3623 | RSS: Main: 171970560 05:12:22 INFO - PID 3623 | 05:15:26 INFO - PID 3623 | Cycle 1(1): loaded http://localhost:53152/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53152/tests/dromaeo/cssquery-ext.html) 05:15:28 INFO - PID 3623 | RSS: Main: 178585600 05:15:28 INFO - PID 3623 | 05:18:30 INFO - PID 3623 | Cycle 1(1): loaded http://localhost:53152/tests/dromaeo/cssquery-ext.html (next: http://localhost:53152/tests/dromaeo/cssquery-jquery.html) 05:18:31 INFO - PID 3623 | RSS: Main: 176963584 05:18:31 INFO - PID 3623 | 05:21:32 INFO - PID 3623 | Cycle 1(1): loaded http://localhost:53152/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53152/tests/dromaeo/cssquery-mootools.html) 05:21:33 INFO - PID 3623 | RSS: Main: 179539968 05:21:33 INFO - PID 3623 | 05:24:35 INFO - PID 3623 | Cycle 1(1): loaded http://localhost:53152/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53152/tests/dromaeo/cssquery-prototype.html) 05:24:35 INFO - PID 3623 | RSS: Main: 178663424 05:24:35 INFO - PID 3623 | 05:27:38 INFO - PID 3623 | Cycle 1(1): loaded http://localhost:53152/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53152/tests/dromaeo/cssquery-yui.html) 05:27:39 INFO - PID 3623 | RSS: Main: 176771072 05:27:39 INFO - PID 3623 | 05:30:40 INFO - PID 3623 | Cycle 1(1): loaded http://localhost:53152/tests/dromaeo/cssquery-yui.html (next: http://localhost:53152/tests/dromaeo/cssquery-dojo.html) 05:30:41 INFO - PID 3623 | RSS: Main: 181256192 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | __start_tp_report 05:30:41 INFO - PID 3623 | _x_x_mozilla_page_load 05:30:41 INFO - PID 3623 | _x_x_mozilla_page_load_details 05:30:41 INFO - PID 3623 | |i|pagename|runs| 05:30:41 INFO - PID 3623 | |0;dojo.html;3110.0825256549315;3152.243461569223;3182.5385319128727;3193.058047875877;3195.760317976151;6082.939170608292;6091.847703807407;6110.6802680506635;6117.602355846867;6133.946794548711;6022.578419510636;6159.630422174672;6169.907451388232;6182.6290422574675;6201.968990155055;5676.801311954083;5694.914576281359;5750.3962083981205;5768.39431859655;5839.941600583982;5721.771129154808;5794.68129252891;5810.56420768442;5832.445917637839;5840.941590584103;5589.329280486327;5635.8591035224035;5647.887042259173;5706.115552089433;5711.885762284731;5553.694546799924;5601.103823388238;5626.268585083953;5644.096944488903;5758.510526605243;5655.886882262373;5664.320281566197;5689.345725241609;5710.71446427677;5713.371529131792;6077.20996270482;6085.5435842312;6128.203333566652;6138.815835524942;6155.907661385083;6620.304867988888;6644.036614690891;6680.131582894242;6680.933190668128;6687.866242675168;6574.868502629968;6594.93405065948;6640.1035860158745;6653.634050127241;6695.230048544431;6120;6121.785737499255;6128.167033931239;6137.714085983976;6168.414000669929;6750.797476075725;6795.72817087311;6802.489813264025;6807.591544507345;6808.863822723518;6350.555461117678;6460.45086167681;6461.903071453932;6474.093626892239;6475.061116138134;6550.148480697479;6567.047778072249;6570.77002304917;6647.202335719745;6661.866762664719;6648;6689.531732778756;6691.531592788556;6696.799096027127;6698.63157526331;6620.437262832713;6654.70053847578;6662.86674266512;6667.133272674521;6674.499412544079;5311.9734401328515;5360.731963401814;5371.140617501181;5387.030334539742;5413.593980451403;4619.930701039487;4706.811727530929;4713.6936099153445;4723.811047558128;4733.195356789354;5754.539636829044;5775.537956963517;5810.970945145332;5827.096799996008;5840.941590584125;6712.630805305755;6750.3924646782025;6761.594304341756;6765.830854228684;6795.18457785059;5810;5829.47534721877;5834.445727655866;5835.941640583625;5839;5735.7418916148035;5830.970845145747;5850.8537286567325;5877.94122058774;5895.970520147372;6409.487241020801;6448.097266382711;6469.644169570719;6479.643619600967;6481.740730370921;6710.66446677674;6725.428338591275;6737.157855268091;6742.089817874524;6749.696263668245;6456.386643268882;6467;6500.967495162494;6516.934830651633;6525.8694826104165;6384.648844313608;6476.31998640136;6574.901376479453;6586.703598338182;6597;6539.869202615826;6571.967140164268;6630.30381809903;6636.1373021508825;6735;6431.710573024318;6490.675466226764;6514.2834288229205;6531.673416329069;6548.639824809681;6528.934710652833;6535.705893234911;6553.901691474727;6554.344565543408;6575.868482630416;6182.258129024366;6352.745890164341;6409.327020662763;6411.070394792822;6444.516661250331;6441.098246245436;6484.351564843667;6511.446527045254;6536.3136870627895;6550.181227346582;6275.843103922439;6307.05394190875;6337;6367.044943258548;6367.554271200971 05:30:41 INFO - PID 3623 | |1;ext.html;690.76513985245;733.757859906231;766.980825479363;788.7554857994019;790.9802254943626;41001.79499102504;41594.37608435876;41910.790446047766;42102.57897421025;42227;38319;38583.61416385835;38620.61379386205;38766.22467550647;38891.22217555654;6829.078074459946;6940.444764418834;6942.271061538541;6946.166460024804;6947.513674042819;6849.520533562652;6937.653117344138;6957.79126626202;6960.860782784342;6964.791056268295;6908.7236510539515;6921.723131074751;6941.826454338631;6953.37419632233;6953.408960238386;6853.451723862079;6895.5173137880365;6901.930980690179;6904.896426553581;6929.307069293056;6180.5982611130585;6190.319064902902;6196.566240363177;6197.03945888388;6220.222472190976;32682.836585817156;33022.17444563905;33393.33213335744;33465.33069338599;33472.6652733472;3377.493375993596;3420.9486857697157;3490.877819276313;3578.7137029037613;3580.820958952042;31116;31463.37073258522;31485.37029259425;31568.210794730086;31596.36807263865;3818.3508803503473;3819.3316169670475;3839.155385815116;3842.4620553122586;3897.9610203897882;193211;195270;195641;197293;197520.99999999857;44237.336439953426;50968.49031509637;52078.739606302486;52475.737621312415;52639.473605264226;54410.72794636081;54707;54957.72521137448;55067.72466137644;55160.44839551553;15960.680786384208;16025.759613605805;16047;16059.839401606068;16096.275667594986;13087.607371778862;13112.803307950388;13153.342332883318;13168.209907405586;13189.076764626576;14840;14936.775948360782;14940.252987350807;14959.252037398304;15069.09585424878;5794.159846822187;5840.269966254218;5895.380984996599;5920.970395147997;5944.395013346372;976.4287891583361;986.8125056239292;992.6079198716467;1015.355249416611;1043.1602559939322;22961.88519057394;23250.767492325198;23252.883735581552;23686.170984015476;24436.14473493419;1035.177034257767;1075.6772968109535;1107.983380249297;1150.0856818829052;1154.2151337090859;12029.518819247132;13059.804102938464;13179;13294.601161965156;13305.667358315926;238280;239993;240078;240756;241107;53186.46813531815;53511.732441338325;53526.46473535215;53632.46367536275;53663.73168134134;1389.208151353739;1472.9926350368394;1480.2820631993475;1486.568895020432;1494.0662086196128;22092.779072209716;23598.646020309367;23920.282391528282;24106.156284530658;24431.633525496778;38397.61602384052;38441;38448.80775596104;38764.6123538761;38781.80609096937;208334;209014;211980;212231;212294;31467.527987079753;32279.193020174684;32523.83738081389;34746.30507389788;35287.64712352843;42246.366304506075;43406.78296608497;43658.781706091264;43790;45158;31086.533701994034;31549.8422507886;32117.197070073435;32511;33507.162320942174;31141.065768026994;32578.348433031682;33241;33478.665213348526;33802.66197337995;35937.82031089828;36950.63049369472;37101.44347834839;38026.42960355652;38602.80698596489;27994.86002569974;29839.403211935205;30209;30491.695083048886;30701.53947690831;23434.296971090895;24739.154997175556;24902.12842550502;25421.61867571951;25720.742792572582 05:30:41 INFO - PID 3623 | |2;jquery.html;550.9366422861369;564.074917135897;564.559643478087;571.5770329955832;605.2222893581747;22075.779242207573;22915.77084229157;22920;22983.540329193405;23008.65487017694;24712;25620.74379256207;26940;27200.183994480198;27206.863965680142;6484.1894763154605;6619.635920024397;6623.403893649571;6645.9003114953075;6653.866922661544;6576.901346479806;6608.2730899601;6650.201975762915;6680.498962577802;6681.465482761391;6131.816045518642;6253.874922501547;6369.8407539811415;6475.935240647604;6628.867422651544;6524.543281970264;6552.049952756847;6572.07990881277;6577.901331480031;6587.73649054042;6100.7254673539355;6121.693915304217;6134.9386506134815;6139.1712118863825;6165.7533698652;26907.46185076307;28829;28921.276968075756;29218.853905730335;29226.853865730536;1876.3339014649875;1908.055512521311;1908.6850669639632;1916.2718167096414;1918.5011896906765;18049.548761281072;18538.258469661196;18539.72190417145;18543.07284635776;18581;2365.8817059147145;2366.7633236676365;2378.750231225714;2443.511297740459;2450.914218002379;121936.39031804784;127196;128122.718772812;128164.35917820444;128633;14018.859811401959;14553.490627827976;14839;15269.770953435707;15730.449434269745;22936.541269174522;23077.961491732913;23194.188203413138;23314.300570982898;23371.41571460693;9697.224222062217;9756.268279879037;9835.262355323379;9960.410293323788;10032.598696052222;8881.37830351882;8934.463932164092;8982.775430614156;9027.187553120251;9129.178373946377;8876.20114189726;9190.862137067948;9243.90756092444;9276.165145136834;9300.906990930003;2566.576514875062;2676.2774051006118;2704.3104008478103;2782.234885406489;2880.3807181456086;930.5207817973749;937.105064663245;950.1116456113556;998.5007496251874;1003.2876657573205;19396.903015484833;19916.506262030405;19999.800002000084;20406;20505.2823151189;961.1829944547219;975.3611384543135;999.5452069308448;1008.7780688248573;1021.116734025063;10651.467426628638;10879.619213327655;10939.83590246147;11045.226834121695;11138.10895128404;419094;448521;453673;461910;465003;109472.4526377363;113246;114770;114785.42607287077;114857.42571287257;1162.4331749700016;1182.1724792645182;1217.2209785737136;1228.121892846619;1236.6537369536545;19339.4198174055;21204.939753012597;21633.13467461284;21955.890220548794;21958.670619941033;51603;54319;54324.72837635787;54662.453375467325;55668.721656391455;67737.66131169313;68240.6587967057;68527.3147268521;69873.65063174651;70287.29712702807;12832.358382081045;12933.159344642945;12967;12970.416331264927;13005.089643724848;18156.092195390444;18390.172442239862;18792.906035469736;18923.716144258124;18958.905205473886;14254.501092461715;15075.773863391838;15115.470958516398;15310.38758449694;15466.458673946358;12876;13002.479900803863;13339.333033348488;13577.660558486117;13811.792823107862;15971.28129234164;16437.83562164363;17128.143592820557;17356.305747769948;17390.739138912675;17602.559936001704;17910.10449477547;18068;18098.185581649122;18170;15674.9216253918;16060.759088613913;16348.10085445312;16459.67080658404;16547.66904661876 05:30:41 INFO - PID 3623 | |3;mootools.html;1349.527665317139;1404.59968908861;1420.3608376230693;1424.7577911755;1429.1782225220502;13197.736045279089;13746.450141994308;13768.311584420764;13808.240546769923;13846.10000349979;13767.311634418289;13897.444102235924;13988.790168147487;14019.088759230643;14046.64883377916;2625.750553697396;2640.986795066022;2659.2421159969413;2669.145873320538;2670.492606404787;2540.961885571718;2582.19951814938;2585.28904551249;2594.662693849797;2600.375909781658;2520.6471094046847;2530.127106148376;2563.47448773002;2564.064116597438;2567.79457643389;2477.603583426643;2492.015653816741;2494.451220731436;2499.5000999800113;2504.949901001979;2412.0954642009247;2417.673614062114;2423.3578101803037;2451.4851881104987;2454.4232105455203;13197.406116724771;13566.59300220995;13568;13579.388927498287;13583.796243056264;7320.414366850639;7563.924360756377;7595.696172153107;7603.201663825274;7610.695572177106;4111.938320925188;4262.531121576624;4366.973761166123;4376.803043863034;4391.912161756747;1581.7627355896593;1617.8463046010727;1627.5686942960126;1670.3986564836648;1672.8828981971267;19464.70802937957;20158.29445969399;21747.13011479539;21782;22007;5517.972410137923;5702.6293290935955;6280;6379.681015949184;6533.901991470132;14761.630959226106;14773.92613036928;14811.555653330417;14814.333354998835;14827.629309267355;7085.610291434021;7195.316444937723;7221.061262036007;7224.927750722531;7227.205007449176;6777.796666100025;6845.726170953106;6848.657567121624;6849;6893.241743408221;4834.540718631724;5016.799328026911;5037.168867136955;5038.294638750578;5059.924101138412;1453.4840131753288;1496.85779850914;1506.7815166800754;1523.124203582922;1527.0608575726071;903.7650210945202;905.117510427328;907.5280853955906;924.177482040984;942.0391200974967;7098.680559374738;7394.963025184839;7592.582407967615;8613.440126391764;8754.51850148248;987.0474991633108;1000.0249756487367;1018.2464975917768;1034.6068493972393;1037.5008113276394;5026.698398096126;5084.949150508522;5414.214938833847;5426.267453893753;5475.564792518073;18204.45386638403;18805;19023.429297121107;19039.714404283946;19071.80928190728;18311.81688183101;18442.262309507736;18449.53876153107;18554.628907421775;18594.070296485123;9490.762730931643;9912.306138570375;10163.136133428594;10194.694159175087;10278.074973252295;8063.314618257514;8106.797330066795;8323.41736078493;8341.916580834357;8567.528785916835;15353.155576443403;15650.843491565394;15923.52229433119;16190.271437785092;16236.26936787871;15885.364585416915;16050.357985680908;16245.187740612686;16406.343746250015;16414.507564773077;11011.779764404508;11067.557297708001;11263;11318.886811132114;11560;12691.619251422471;12843;12847.807282890952;12864.163829351062;12898.226106433644;10077.949610251902;10181.643642472774;10403.583856645952;10584.206184536037;10804.783904322027;9651.131398174199;10011.499425028866;10061.949690251795;10109.191264698953;10217.284790064625;9344.299177561847;9527.57125929321;9548.570314335733;9552.42685438876;9593.712188634352;6569.178852643419;6607.669616519059;6692.130023096966;6815.625140617115;6878.65606719672;7158.950432667476;7347.632618369167;7436.59098749574;7497.062867141607;7584.317411432777 05:30:41 INFO - PID 3623 | |4;prototype.html;472.1124286341677;499.1514425476689;499.5828483216514;516.4035538952506;525.723994902676;6246.875062498753;6270.184875966118;6290.685465726707;6338.397852204033;6346.365363463657;5946.940530594693;6108.328083910777;6171.105189747495;6187.412195841399;6207.317195108534;4898.730569818658;4912.838351125502;4940.703557786526;4945.381827271591;4953.950460495403;4911.607071434277;4927.2855435961765;4945.208766597345;4961.429435614897;4970;4931.65478416511;4946.802127914879;4960.578350840183;4968.627352948525;4971.353724015873;4726.432828060638;4870.342503761982;4888.437829649601;4914.385701787277;4914.459409464956;4380.123975204971;4402.955970440286;4407.294832826732;4431.446069241345;4435.512093669726;5994.460498555108;6022.187004754346;6022.2171117754415;6042.395760423967;6045.3047899491685;5530.5852061095575;5592.4407559244155;5597.944020559783;5604.411536788619;5621.156826476021;6515.576487528296;6530.869382612369;6548.869022619521;6567.835804104888;6627.602343859384;4771.570558649738;4845.903081938377;4846.806127754886;4864.148773964577;4882.829100981484;6815.522913396015;6885.862282754317;6902.723891044352;6919.8962015569805;6963.67690138872;4961.131801934647;4962.156433406258;4980.8754781130765;4991.376077990251;5015.598752099823;5006.224035274538;5044.167712327425;5054.570361519239;5057.494250574913;5062.7215503146945;5644.520215781705;5653.717314134359;5682.289713785777;5688.658680479184;5697.857553561194;6622.437092847065;6626.83432914181;6630.138082049302;6671.366220209073;6702.229243637044;1631.282235816237;1750.571110078039;1755.1926113987454;1757.4903278049478;1770.9557261068576;1222.3460448659923;1225.5526732742485;1227.5142835757663;1233.8334324866028;1244.3094082784141;5584.720763961785;5741.511971482387;5747.3103227612955;5789.986752318412;5810.854728631733;6603.339666033455;6736.797896063126;6747.392734653807;6748.527603067836;6761.256261811197;5732.503173064428;5739.8852022960145;5747.770089196385;5751.654900705971;5767.653940763567;3568.7858728475853;3576.070221742366;3581.731370147197;3587.5694916610173;3594.8562057517406;6531.314212007671;6550.70521826519;6553.311902250291;6554.3117972613145;6556.246031706415;6818.624975626388;6901.756174597931;6907.654617269116;6917.965410172917;6930.099087118743;6527.184101987252;6538.215414150237;6545;6551.594934179226;6570.967145164243;6727.663616819042;6734.427573656294;6738.831529211809;6746.730130794714;6766.96616516934;6583.80248592543;6609.239937407259;6649.135612370555;6656.866862662817;6662.233843107911;6284.151639528605;6516.674166291572;6517.4134327910715;6547.770828020996;6571.5399922005;4905.337779399735;4915.410150781929;4931.580815630568;4947.282644016525;4961.677490963076;6659.467242620482;6685.323072310112;6690.765823196165;6693.866122677422;6767.627780471925;6456;6470.5147113965695;6511.446527045254;6525.06219340398;6543.1821022372205;6518.837029074311;6534.4772418205475;6543.476521878143;6544.869102618016;6561.507886908405;6447.323695839022;6455.61266324022;6458.935410646021;6466.612003279818;6495.408624886933;6559.704813283509;6587.176602924635;6588.374104460068;6599.307072757291;6633.966830166011;6397.712102955471;6405.711742971671;6406.967965160145;6408.58344207625;6409.8718025640155 05:30:41 INFO - PID 3623 | |5;yui.html;830.3896635972563;860.0324634785866;865.4763867859945;870.6778491957973;877.7761670773949;17484.125793710296;17502.91248543757;17929.10354482277;18018.5495362616;18062.277508899628;18693.34573289935;20280.492987675316;20668.06993685284;20725.792742072612;20876.58246835066;1023.1507848485776;1044.8328267477204;1045.7594753206768;1046.7906418716286;1051.1538211739546;1047.6909311753013;1047.9423631700254;1048.7220886465093;1049.2864851900742;1050.5220124843215;1032.958681652733;1110.3005106782755;1112.5216157052464;1115.1469126118525;1117.5027112934747;1078.471548941017;1083.7290677330668;1083.815751322277;1085.478970094359;1087.34215799441;791.0665414810579;795.2802713544252;797.9760607181794;798.6206551887865;800.131856935226;18126.456206313833;18313.816861831343;18649.067546622613;18759.624807503773;18767;18299.268029278945;18593.44219673412;18643.533911652183;18678.25286988519;19034.33379831699;15268.16025118618;15287.464938727091;15395.461158859498;15423.845761542354;15553.844461555353;3456.1532424555894;3494.545709057806;3584.193556449778;3619.5294611700574;3634.545681789776;100787;102476;103044.48477757638;103816.48091759493;105794.47102764514;14722.116672999655;14882.851171488363;15009.924950375178;15035.699286014218;15073.924630376778;26858.5971210432;27321.453570928472;27747;27929.301767455978;28045.57931631027;8037.276645101969;8317.792055198548;8398.538080405515;8411.957940210383;8430.494170349799;3872.7289089763444;3934.5475270343704;3944.0928586425284;3946.644801967837;3956.149427873021;4873.41519017713;4930.33440485537;5229.555487783505;5442.2108794225405;5496.5053145217125;865.0700496965787;902.3232575568323;903.7108125399809;1012.5949620151998;1028.573142146016;603.3664652115261;663.3068443476578;683.6376720338229;684.2815044203567;712.383788023356;10357.792844143074;10364.533595988049;10494.370337779757;10686.465676716132;11128.165387595962;682.3279070115932;688.9517733758589;689.300360134464;690.9481788865855;712.9839978031284;4871.488493708181;4913.164761990471;4993.675411098267;5079.822206222764;5101.642884998015;86380;86546.56726716452;89814;91802.08197917935;92736;86268;87452;88037;89714.55142724245;91768.54115729513;70671.6466417675;71374;71420.28579714136;74002.62998685079;75586.86619700708;9574.473403962571;9687.903120968982;9894.752631184278;10200.132988696045;10236.897631023594;31628;32672.673273266962;33263.83368083144;33490.497642534894;34291.65708342985;42108.368374473794;43268.78365608152;43422.56577434185;43526.782366087966;43989.12021759611;13763;13771.311434428038;13799.51701690436;13820;13948.511802087283;13738.313084345942;14054.929725351309;14060.789088163481;14099.365528551034;14294.356753945889;12632.936835315764;13362.465501379836;13540.119892206974;13699.246541440316;13702.725945481234;11751.882481175078;11825.704357391134;11927.940360298144;12042.518299267931;12045.81931271014;12971.416286266953;13472.932635336761;13571.728565428439;13619.18284902909;13642;9860.901390986286;10547.156227501935;10748.623798167027;10888.51001704941;10956.616518421817;10722.517486713272;10944.945275273572;11059.944700276446;11262.267952583055;11275.436228188722 05:30:41 INFO - PID 3623 | __end_tp_report 05:30:41 INFO - PID 3623 | __start_cc_report 05:30:41 INFO - PID 3623 | _x_x_mozilla_cycle_collect,358 05:30:41 INFO - PID 3623 | __end_cc_report 05:30:41 INFO - PID 3623 | __startTimestamp1498480241074__endTimestamp 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | ------- Summary: start ------- 05:30:41 INFO - PID 3623 | Number of tests: 6 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | [#0] dojo.html Cycles:165 Average:6122.69 Median:6367.55 stddev:709.07 (11.1%) stddev-sans-first:670.70 05:30:41 INFO - PID 3623 | Values: 3110.1 3152.2 3182.5 3193.1 3195.8 6082.9 6091.8 6110.7 6117.6 6133.9 6022.6 6159.6 6169.9 6182.6 6202.0 5676.8 5694.9 5750.4 5768.4 5839.9 5721.8 5794.7 5810.6 5832.4 5840.9 5589.3 5635.9 5647.9 5706.1 5711.9 5553.7 5601.1 5626.3 5644.1 5758.5 5655.9 5664.3 5689.3 5710.7 5713.4 6077.2 6085.5 6128.2 6138.8 6155.9 6620.3 6644.0 6680.1 6680.9 6687.9 6574.9 6594.9 6640.1 6653.6 6695.2 6120.0 6121.8 6128.2 6137.7 6168.4 6750.8 6795.7 6802.5 6807.6 6808.9 6350.6 6460.5 6461.9 6474.1 6475.1 6550.1 6567.0 6570.8 6647.2 6661.9 6648.0 6689.5 6691.5 6696.8 6698.6 6620.4 6654.7 6662.9 6667.1 6674.5 5312.0 5360.7 5371.1 5387.0 5413.6 4619.9 4706.8 4713.7 4723.8 4733.2 5754.5 5775.5 5811.0 5827.1 5840.9 6712.6 6750.4 6761.6 6765.8 6795.2 5810.0 5829.5 5834.4 5835.9 5839.0 5735.7 5831.0 5850.9 5877.9 5896.0 6409.5 6448.1 6469.6 6479.6 6481.7 6710.7 6725.4 6737.2 6742.1 6749.7 6456.4 6467.0 6501.0 6516.9 6525.9 6384.6 6476.3 6574.9 6586.7 6597.0 6539.9 6572.0 6630.3 6636.1 6735.0 6431.7 6490.7 6514.3 6531.7 6548.6 6528.9 6535.7 6553.9 6554.3 6575.9 6182.3 6352.7 6409.3 6411.1 6444.5 6441.1 6484.4 6511.4 6536.3 6550.2 6275.8 6307.1 6337.0 6367.0 6367.6 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | [#1] ext.html Cycles:180 Average:38296.48 Median:18611.81 stddev:56206.09 (302.0%) stddev-sans-first:56292.83 05:30:41 INFO - PID 3623 | Values: 690.8 733.8 767.0 788.8 791.0 41001.8 41594.4 41910.8 42102.6 42227.0 38319.0 38583.6 38620.6 38766.2 38891.2 6829.1 6940.4 6942.3 6946.2 6947.5 6849.5 6937.7 6957.8 6960.9 6964.8 6908.7 6921.7 6941.8 6953.4 6953.4 6853.5 6895.5 6901.9 6904.9 6929.3 6180.6 6190.3 6196.6 6197.0 6220.2 32682.8 33022.2 33393.3 33465.3 33472.7 3377.5 3420.9 3490.9 3578.7 3580.8 31116.0 31463.4 31485.4 31568.2 31596.4 3818.4 3819.3 3839.2 3842.5 3898.0 193211.0 195270.0 195641.0 197293.0 197521.0 44237.3 50968.5 52078.7 52475.7 52639.5 54410.7 54707.0 54957.7 55067.7 55160.4 15960.7 16025.8 16047.0 16059.8 16096.3 13087.6 13112.8 13153.3 13168.2 13189.1 14840.0 14936.8 14940.3 14959.3 15069.1 5794.2 5840.3 5895.4 5921.0 5944.4 976.4 986.8 992.6 1015.4 1043.2 22961.9 23250.8 23252.9 23686.2 24436.1 1035.2 1075.7 1108.0 1150.1 1154.2 12029.5 13059.8 13179.0 13294.6 13305.7 238280.0 239993.0 240078.0 240756.0 241107.0 53186.5 53511.7 53526.5 53632.5 53663.7 1389.2 1473.0 1480.3 1486.6 1494.1 22092.8 23598.6 23920.3 24106.2 24431.6 38397.6 38441.0 38448.8 38764.6 38781.8 208334.0 209014.0 211980.0 212231.0 212294.0 31467.5 32279.2 32523.8 34746.3 35287.6 42246.4 43406.8 43658.8 43790.0 45158.0 31086.5 31549.8 32117.2 32511.0 33507.2 31141.1 32578.3 33241.0 33478.7 33802.7 35937.8 36950.6 37101.4 38026.4 38602.8 27994.9 29839.4 30209.0 30491.7 30701.5 23434.3 24739.2 24902.1 25421.6 25720.7 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | [#2] jquery.html Cycles:180 Average:32818.48 Median:23136.07 stddev:75984.64 (328.4%) stddev-sans-first:76159.17 05:30:41 INFO - PID 3623 | Values: 550.9 564.1 564.6 571.6 605.2 22075.8 22915.8 22920.0 22983.5 23008.7 24712.0 25620.7 26940.0 27200.2 27206.9 6484.2 6619.6 6623.4 6645.9 6653.9 6576.9 6608.3 6650.2 6680.5 6681.5 6131.8 6253.9 6369.8 6475.9 6628.9 6524.5 6552.0 6572.1 6577.9 6587.7 6100.7 6121.7 6134.9 6139.2 6165.8 26907.5 28829.0 28921.3 29218.9 29226.9 1876.3 1908.1 1908.7 1916.3 1918.5 18049.5 18538.3 18539.7 18543.1 18581.0 2365.9 2366.8 2378.8 2443.5 2450.9 121936.4 127196.0 128122.7 128164.4 128633.0 14018.9 14553.5 14839.0 15269.8 15730.4 22936.5 23078.0 23194.2 23314.3 23371.4 9697.2 9756.3 9835.3 9960.4 10032.6 8881.4 8934.5 8982.8 9027.2 9129.2 8876.2 9190.9 9243.9 9276.2 9300.9 2566.6 2676.3 2704.3 2782.2 2880.4 930.5 937.1 950.1 998.5 1003.3 19396.9 19916.5 19999.8 20406.0 20505.3 961.2 975.4 999.5 1008.8 1021.1 10651.5 10879.6 10939.8 11045.2 11138.1 419094.0 448521.0 453673.0 461910.0 465003.0 109472.5 113246.0 114770.0 114785.4 114857.4 1162.4 1182.2 1217.2 1228.1 1236.7 19339.4 21204.9 21633.1 21955.9 21958.7 51603.0 54319.0 54324.7 54662.5 55668.7 67737.7 68240.7 68527.3 69873.7 70287.3 12832.4 12933.2 12967.0 12970.4 13005.1 18156.1 18390.2 18792.9 18923.7 18958.9 14254.5 15075.8 15115.5 15310.4 15466.5 12876.0 13002.5 13339.3 13577.7 13811.8 15971.3 16437.8 17128.1 17356.3 17390.7 17602.6 17910.1 18068.0 18098.2 18170.0 15674.9 16060.8 16348.1 16459.7 16547.7 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | [#3] mootools.html Cycles:180 Average:8390.07 Median:2466.01 stddev:5615.86 (227.7%) stddev-sans-first:5606.70 05:30:41 INFO - PID 3623 | Values: 1349.5 1404.6 1420.4 1424.8 1429.2 13197.7 13746.5 13768.3 13808.2 13846.1 13767.3 13897.4 13988.8 14019.1 14046.6 2625.8 2641.0 2659.2 2669.1 2670.5 2541.0 2582.2 2585.3 2594.7 2600.4 2520.6 2530.1 2563.5 2564.1 2567.8 2477.6 2492.0 2494.5 2499.5 2504.9 2412.1 2417.7 2423.4 2451.5 2454.4 13197.4 13566.6 13568.0 13579.4 13583.8 7320.4 7563.9 7595.7 7603.2 7610.7 4111.9 4262.5 4367.0 4376.8 4391.9 1581.8 1617.8 1627.6 1670.4 1672.9 19464.7 20158.3 21747.1 21782.0 22007.0 5518.0 5702.6 6280.0 6379.7 6533.9 14761.6 14773.9 14811.6 14814.3 14827.6 7085.6 7195.3 7221.1 7224.9 7227.2 6777.8 6845.7 6848.7 6849.0 6893.2 4834.5 5016.8 5037.2 5038.3 5059.9 1453.5 1496.9 1506.8 1523.1 1527.1 903.8 905.1 907.5 924.2 942.0 7098.7 7395.0 7592.6 8613.4 8754.5 987.0 1000.0 1018.2 1034.6 1037.5 5026.7 5084.9 5414.2 5426.3 5475.6 18204.5 18805.0 19023.4 19039.7 19071.8 18311.8 18442.3 18449.5 18554.6 18594.1 9490.8 9912.3 10163.1 10194.7 10278.1 8063.3 8106.8 8323.4 8341.9 8567.5 15353.2 15650.8 15923.5 16190.3 16236.3 15885.4 16050.4 16245.2 16406.3 16414.5 11011.8 11067.6 11263.0 11318.9 11560.0 12691.6 12843.0 12847.8 12864.2 12898.2 10077.9 10181.6 10403.6 10584.2 10804.8 9651.1 10011.5 10061.9 10109.2 10217.3 9344.3 9527.6 9548.6 9552.4 9593.7 6569.2 6607.7 6692.1 6815.6 6878.7 7159.0 7347.6 7436.6 7497.1 7584.3 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | [#4] prototype.html Cycles:180 Average:5500.89 Median:6076.82 stddev:1555.63 (25.6%) stddev-sans-first:1513.51 05:30:41 INFO - PID 3623 | Values: 472.1 499.2 499.6 516.4 525.7 6246.9 6270.2 6290.7 6338.4 6346.4 5946.9 6108.3 6171.1 6187.4 6207.3 4898.7 4912.8 4940.7 4945.4 4954.0 4911.6 4927.3 4945.2 4961.4 4970.0 4931.7 4946.8 4960.6 4968.6 4971.4 4726.4 4870.3 4888.4 4914.4 4914.5 4380.1 4403.0 4407.3 4431.4 4435.5 5994.5 6022.2 6022.2 6042.4 6045.3 5530.6 5592.4 5597.9 5604.4 5621.2 6515.6 6530.9 6548.9 6567.8 6627.6 4771.6 4845.9 4846.8 4864.1 4882.8 6815.5 6885.9 6902.7 6919.9 6963.7 4961.1 4962.2 4980.9 4991.4 5015.6 5006.2 5044.2 5054.6 5057.5 5062.7 5644.5 5653.7 5682.3 5688.7 5697.9 6622.4 6626.8 6630.1 6671.4 6702.2 1631.3 1750.6 1755.2 1757.5 1771.0 1222.3 1225.6 1227.5 1233.8 1244.3 5584.7 5741.5 5747.3 5790.0 5810.9 6603.3 6736.8 6747.4 6748.5 6761.3 5732.5 5739.9 5747.8 5751.7 5767.7 3568.8 3576.1 3581.7 3587.6 3594.9 6531.3 6550.7 6553.3 6554.3 6556.2 6818.6 6901.8 6907.7 6918.0 6930.1 6527.2 6538.2 6545.0 6551.6 6571.0 6727.7 6734.4 6738.8 6746.7 6767.0 6583.8 6609.2 6649.1 6656.9 6662.2 6284.2 6516.7 6517.4 6547.8 6571.5 4905.3 4915.4 4931.6 4947.3 4961.7 6659.5 6685.3 6690.8 6693.9 6767.6 6456.0 6470.5 6511.4 6525.1 6543.2 6518.8 6534.5 6543.5 6544.9 6561.5 6447.3 6455.6 6458.9 6466.6 6495.4 6559.7 6587.2 6588.4 6599.3 6634.0 6397.7 6405.7 6407.0 6408.6 6409.9 05:30:41 INFO - PID 3623 | 05:30:41 INFO - PID 3623 | [#5] yui.html Cycles:180 Average:19622.29 Median:18726.49 stddev:26444.52 (141.2%) stddev-sans-first:26481.06 05:30:41 INFO - PID 3623 | Values: 830.4 860.0 865.5 870.7 877.8 17484.1 17502.9 17929.1 18018.5 18062.3 18693.3 20280.5 20668.1 20725.8 20876.6 1023.2 1044.8 1045.8 1046.8 1051.2 1047.7 1047.9 1048.7 1049.3 1050.5 1033.0 1110.3 1112.5 1115.1 1117.5 1078.5 1083.7 1083.8 1085.5 1087.3 791.1 795.3 798.0 798.6 800.1 18126.5 18313.8 18649.1 18759.6 18767.0 18299.3 18593.4 18643.5 18678.3 19034.3 15268.2 15287.5 15395.5 15423.8 15553.8 3456.2 3494.5 3584.2 3619.5 3634.5 100787.0 102476.0 103044.5 103816.5 105794.5 14722.1 14882.9 15009.9 15035.7 15073.9 26858.6 27321.5 27747.0 27929.3 28045.6 8037.3 8317.8 8398.5 8412.0 8430.5 3872.7 3934.5 3944.1 3946.6 3956.1 4873.4 4930.3 5229.6 5442.2 5496.5 865.1 902.3 903.7 1012.6 1028.6 603.4 663.3 683.6 684.3 712.4 10357.8 10364.5 10494.4 10686.5 11128.2 682.3 689.0 689.3 690.9 713.0 4871.5 4913.2 4993.7 5079.8 5101.6 86380.0 86546.6 89814.0 91802.1 92736.0 86268.0 87452.0 88037.0 89714.6 91768.5 70671.6 71374.0 71420.3 74002.6 75586.9 9574.5 9687.9 9894.8 10200.1 10236.9 31628.0 32672.7 33263.8 33490.5 34291.7 42108.4 43268.8 43422.6 43526.8 43989.1 13763.0 13771.3 13799.5 13820.0 13948.5 13738.3 14054.9 14060.8 14099.4 14294.4 12632.9 13362.5 13540.1 13699.2 13702.7 11751.9 11825.7 11927.9 12042.5 12045.8 12971.4 13472.9 13571.7 13619.2 13642.0 9860.9 10547.2 10748.6 10888.5 10956.6 10722.5 10944.9 11059.9 11262.3 11275.4 05:30:41 INFO - PID 3623 | -------- Summary: end -------- 05:30:41 INFO - PID 3623 | 05:30:41 INFO - TEST-INFO | 3623: exit 0 05:30:41 INFO - TEST-OK | dromaeo_css | took 1120062ms 05:30:41 INFO - TEST-START | kraken 05:30:41 INFO - operating with platform_type : linux_ 05:30:41 INFO - Initialising browser for kraken test... 05:30:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53152/getInfo.html -profile /tmp/tmps116Bh/profile 05:30:41 INFO - TEST-INFO | started process 4040 (/builds/slave/test/build/application/firefox/firefox http://localhost:53152/getInfo.html) 05:30:47 INFO - TEST-INFO | 4040: exit 0 05:30:47 INFO - Browser initialized. 05:30:47 INFO - Running cycle 1/1 for kraken test... 05:30:47 INFO - TEST-INFO | started process 4267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps116Bh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:59 INFO - PID 4267 | RSS: Main: 171966464 05:30:59 INFO - PID 4267 | 05:31:01 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53152/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:02 INFO - PID 4267 | RSS: Main: 176324608 05:31:02 INFO - PID 4267 | 05:31:05 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53152/tests/kraken/driver.html?testName=audio-dft) 05:31:06 INFO - PID 4267 | RSS: Main: 176881664 05:31:06 INFO - PID 4267 | 05:31:09 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53152/tests/kraken/driver.html?testName=audio-fft) 05:31:09 INFO - PID 4267 | RSS: Main: 171724800 05:31:09 INFO - PID 4267 | 05:31:11 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53152/tests/kraken/driver.html?testName=audio-oscillator) 05:31:12 INFO - PID 4267 | RSS: Main: 172400640 05:31:12 INFO - PID 4267 | 05:31:14 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53152/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:15 INFO - PID 4267 | RSS: Main: 172646400 05:31:15 INFO - PID 4267 | 05:31:18 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53152/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:18 INFO - PID 4267 | RSS: Main: 175648768 05:31:18 INFO - PID 4267 | 05:31:22 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53152/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:22 INFO - PID 4267 | RSS: Main: 177401856 05:31:22 INFO - PID 4267 | 05:31:25 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53152/tests/kraken/driver.html?testName=json-parse-financial) 05:31:26 INFO - PID 4267 | RSS: Main: 176721920 05:31:26 INFO - PID 4267 | 05:31:27 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53152/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:28 INFO - PID 4267 | RSS: Main: 176295936 05:31:28 INFO - PID 4267 | 05:31:30 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:30 INFO - PID 4267 | RSS: Main: 176906240 05:31:30 INFO - PID 4267 | 05:31:33 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:33 INFO - PID 4267 | RSS: Main: 176566272 05:31:33 INFO - PID 4267 | 05:31:36 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:37 INFO - PID 4267 | RSS: Main: 176603136 05:31:37 INFO - PID 4267 | 05:31:40 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:40 INFO - PID 4267 | RSS: Main: 176709632 05:31:40 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | Cycle 1(1): loaded http://localhost:53152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53152/tests/kraken/driver.html?testName=ai-astar) 05:31:42 INFO - PID 4267 | RSS: Main: 178266112 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | __start_tp_report 05:31:42 INFO - PID 4267 | _x_x_mozilla_page_load 05:31:42 INFO - PID 4267 | _x_x_mozilla_page_load_details 05:31:42 INFO - PID 4267 | |i|pagename|runs| 05:31:42 INFO - PID 4267 | |0;ai-astar;102;106;108;107;116;107;108;108;108;109 05:31:42 INFO - PID 4267 | |1;audio-beat-detection;161;122;147;169;121;151;150;130;172;120 05:31:42 INFO - PID 4267 | |2;audio-dft;163;161;162;161;163;169;164;163;167;166 05:31:42 INFO - PID 4267 | |3;audio-fft;74;75;76;163;76;75;74;74;95;76 05:31:42 INFO - PID 4267 | |4;audio-oscillator;82;81;148;81;82;81;129;81;81;136 05:31:42 INFO - PID 4267 | |5;imaging-gaussian-blur;113;113;114;114;114;114;113;114;113;114 05:31:42 INFO - PID 4267 | |6;imaging-darkroom;150;149;150;150;151;149;150;151;153;150 05:31:42 INFO - PID 4267 | |7;imaging-desaturate;94;94;95;94;94;93;94;95;94;93 05:31:42 INFO - PID 4267 | |8;json-parse-financial;54;54;54;54;54;54;59;54;53;53 05:31:42 INFO - PID 4267 | |9;json-stringify-tinderbox;54;53;53;53;54;54;54;54;53;53 05:31:42 INFO - PID 4267 | |10;stanford-crypto-aes;77;75;77;78;77;76;76;84;77;75 05:31:42 INFO - PID 4267 | |11;stanford-crypto-ccm;126;128;127;139;136;134;131;124;132;155 05:31:42 INFO - PID 4267 | |12;stanford-crypto-pbkdf2;183;199;185;186;186;188;187;183;194;183 05:31:42 INFO - PID 4267 | |13;stanford-crypto-sha256-iterative;69;69;69;67;68;69;68;71;72;71 05:31:42 INFO - PID 4267 | __end_tp_report 05:31:42 INFO - PID 4267 | __start_cc_report 05:31:42 INFO - PID 4267 | _x_x_mozilla_cycle_collect,919 05:31:42 INFO - PID 4267 | __end_cc_report 05:31:42 INFO - PID 4267 | __startTimestamp1498480302813__endTimestamp 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | ------- Summary: start ------- 05:31:42 INFO - PID 4267 | Number of tests: 14 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.00 stddev:3.45 (3.2%) stddev-sans-first:2.92 05:31:42 INFO - PID 4267 | Values: 102.0 106.0 108.0 107.0 116.0 107.0 108.0 108.0 108.0 109.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.50 stddev:19.93 (13.2%) stddev-sans-first:20.21 05:31:42 INFO - PID 4267 | Values: 161.0 122.0 147.0 169.0 121.0 151.0 150.0 130.0 172.0 120.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.64 (1.6%) stddev-sans-first:2.78 05:31:42 INFO - PID 4267 | Values: 163.0 161.0 162.0 161.0 163.0 169.0 164.0 163.0 167.0 166.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#3] audio-fft Cycles:10 Average:85.80 Median:75.50 stddev:27.86 (36.9%) stddev-sans-first:29.22 05:31:42 INFO - PID 4267 | Values: 74.0 75.0 76.0 163.0 76.0 75.0 74.0 74.0 95.0 76.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:81.00 stddev:27.61 (34.1%) stddev-sans-first:28.66 05:31:42 INFO - PID 4267 | Values: 82.0 81.0 148.0 81.0 82.0 81.0 129.0 81.0 81.0 136.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:31:42 INFO - PID 4267 | Values: 113.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 05:31:42 INFO - PID 4267 | Values: 150.0 149.0 150.0 150.0 151.0 149.0 150.0 151.0 153.0 150.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:31:42 INFO - PID 4267 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 94.0 95.0 94.0 93.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.70 (3.2%) stddev-sans-first:1.80 05:31:42 INFO - PID 4267 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 59.0 54.0 53.0 53.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 05:31:42 INFO - PID 4267 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 54.0 54.0 53.0 53.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:2.57 (3.3%) stddev-sans-first:2.73 05:31:42 INFO - PID 4267 | Values: 77.0 75.0 77.0 78.0 77.0 76.0 76.0 84.0 77.0 75.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:133.00 stddev:8.98 (6.8%) stddev-sans-first:9.14 05:31:42 INFO - PID 4267 | Values: 126.0 128.0 127.0 139.0 136.0 134.0 131.0 124.0 132.0 155.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:186.50 stddev:5.23 (2.8%) stddev-sans-first:5.30 05:31:42 INFO - PID 4267 | Values: 183.0 199.0 185.0 186.0 186.0 188.0 187.0 183.0 194.0 183.0 05:31:42 INFO - PID 4267 | 05:31:42 INFO - PID 4267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.66 05:31:42 INFO - PID 4267 | Values: 69.0 69.0 69.0 67.0 68.0 69.0 68.0 71.0 72.0 71.0 05:31:42 INFO - PID 4267 | -------- Summary: end -------- 05:31:42 INFO - PID 4267 | 05:31:43 INFO - TEST-INFO | 4267: exit 0 05:31:43 INFO - TEST-OK | kraken | took 61964ms 05:31:43 INFO - SUITE-END | took 1182s 05:31:44 INFO - Completed test suite (00:19:42) 05:31:44 INFO - javascript benchmark 05:31:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8167.36592001488, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.0825256549315, 3152.243461569223, 3182.5385319128727, 3193.058047875877, 3195.760317976151, 6082.939170608292, 6091.847703807407, 6110.6802680506635, 6117.602355846867, 6133.946794548711, 6022.578419510636, 6159.630422174672, 6169.907451388232, 6182.6290422574675, 6201.968990155055, 5676.801311954083, 5694.914576281359, 5750.3962083981205, 5768.39431859655, 5839.941600583982, 5721.771129154808, 5794.68129252891, 5810.56420768442, 5832.445917637839, 5840.941590584103, 5589.329280486327, 5635.8591035224035, 5647.887042259173, 5706.115552089433, 5711.885762284731, 5553.694546799924, 5601.103823388238, 5626.268585083953, 5644.096944488903, 5758.510526605243, 5655.886882262373, 5664.320281566197, 5689.345725241609, 5710.71446427677, 5713.371529131792, 6077.20996270482, 6085.5435842312, 6128.203333566652, 6138.815835524942, 6155.907661385083, 6620.304867988888, 6644.036614690891, 6680.131582894242, 6680.933190668128, 6687.866242675168, 6574.868502629968, 6594.93405065948, 6640.1035860158745, 6653.634050127241, 6695.230048544431, 6120.0, 6121.785737499255, 6128.167033931239, 6137.714085983976, 6168.414000669929, 6750.797476075725, 6795.72817087311, 6802.489813264025, 6807.591544507345, 6808.863822723518, 6350.555461117678, 6460.45086167681, 6461.903071453932, 6474.093626892239, 6475.061116138134, 6550.148480697479, 6567.047778072249, 6570.77002304917, 6647.202335719745, 6661.866762664719, 6648.0, 6689.531732778756, 6691.531592788556, 6696.799096027127, 6698.63157526331, 6620.437262832713, 6654.70053847578, 6662.86674266512, 6667.133272674521, 6674.499412544079, 5311.9734401328515, 5360.731963401814, 5371.140617501181, 5387.030334539742, 5413.593980451403, 4619.930701039487, 4706.811727530929, 4713.6936099153445, 4723.811047558128, 4733.195356789354, 5754.539636829044, 5775.537956963517, 5810.970945145332, 5827.096799996008, 5840.941590584125, 6712.630805305755, 6750.3924646782025, 6761.594304341756, 6765.830854228684, 6795.18457785059, 5810.0, 5829.47534721877, 5834.445727655866, 5835.941640583625, 5839.0, 5735.7418916148035, 5830.970845145747, 5850.8537286567325, 5877.94122058774, 5895.970520147372, 6409.487241020801, 6448.097266382711, 6469.644169570719, 6479.643619600967, 6481.740730370921, 6710.66446677674, 6725.428338591275, 6737.157855268091, 6742.089817874524, 6749.696263668245, 6456.386643268882, 6467.0, 6500.967495162494, 6516.934830651633, 6525.8694826104165, 6384.648844313608, 6476.31998640136, 6574.901376479453, 6586.703598338182, 6597.0, 6539.869202615826, 6571.967140164268, 6630.30381809903, 6636.1373021508825, 6735.0, 6431.710573024318, 6490.675466226764, 6514.2834288229205, 6531.673416329069, 6548.639824809681, 6528.934710652833, 6535.705893234911, 6553.901691474727, 6554.344565543408, 6575.868482630416, 6182.258129024366, 6352.745890164341, 6409.327020662763, 6411.070394792822, 6444.516661250331, 6441.098246245436, 6484.351564843667, 6511.446527045254, 6536.3136870627895, 6550.181227346582, 6275.843103922439, 6307.05394190875, 6337.0, 6367.044943258548, 6367.554271200971], "value": 6070.44900285229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.76513985245, 733.757859906231, 766.980825479363, 788.7554857994019, 790.9802254943626, 41001.79499102504, 41594.37608435876, 41910.790446047766, 42102.57897421025, 42227.0, 38319.0, 38583.61416385835, 38620.61379386205, 38766.22467550647, 38891.22217555654, 6829.078074459946, 6940.444764418834, 6942.271061538541, 6946.166460024804, 6947.513674042819, 6849.520533562652, 6937.653117344138, 6957.79126626202, 6960.860782784342, 6964.791056268295, 6908.7236510539515, 6921.723131074751, 6941.826454338631, 6953.37419632233, 6953.408960238386, 6853.451723862079, 6895.5173137880365, 6901.930980690179, 6904.896426553581, 6929.307069293056, 6180.5982611130585, 6190.319064902902, 6196.566240363177, 6197.03945888388, 6220.222472190976, 32682.836585817156, 33022.17444563905, 33393.33213335744, 33465.33069338599, 33472.6652733472, 3377.493375993596, 3420.9486857697157, 3490.877819276313, 3578.7137029037613, 3580.820958952042, 31116.0, 31463.37073258522, 31485.37029259425, 31568.210794730086, 31596.36807263865, 3818.3508803503473, 3819.3316169670475, 3839.155385815116, 3842.4620553122586, 3897.9610203897882, 193211.0, 195270.0, 195641.0, 197293.0, 197520.99999999857, 44237.336439953426, 50968.49031509637, 52078.739606302486, 52475.737621312415, 52639.473605264226, 54410.72794636081, 54707.0, 54957.72521137448, 55067.72466137644, 55160.44839551553, 15960.680786384208, 16025.759613605805, 16047.0, 16059.839401606068, 16096.275667594986, 13087.607371778862, 13112.803307950388, 13153.342332883318, 13168.209907405586, 13189.076764626576, 14840.0, 14936.775948360782, 14940.252987350807, 14959.252037398304, 15069.09585424878, 5794.159846822187, 5840.269966254218, 5895.380984996599, 5920.970395147997, 5944.395013346372, 976.4287891583361, 986.8125056239292, 992.6079198716467, 1015.355249416611, 1043.1602559939322, 22961.88519057394, 23250.767492325198, 23252.883735581552, 23686.170984015476, 24436.14473493419, 1035.177034257767, 1075.6772968109535, 1107.983380249297, 1150.0856818829052, 1154.2151337090859, 12029.518819247132, 13059.804102938464, 13179.0, 13294.601161965156, 13305.667358315926, 238280.0, 239993.0, 240078.0, 240756.0, 241107.0, 53186.46813531815, 53511.732441338325, 53526.46473535215, 53632.46367536275, 53663.73168134134, 1389.208151353739, 1472.9926350368394, 1480.2820631993475, 1486.568895020432, 1494.0662086196128, 22092.779072209716, 23598.646020309367, 23920.282391528282, 24106.156284530658, 24431.633525496778, 38397.61602384052, 38441.0, 38448.80775596104, 38764.6123538761, 38781.80609096937, 208334.0, 209014.0, 211980.0, 212231.0, 212294.0, 31467.527987079753, 32279.193020174684, 32523.83738081389, 34746.30507389788, 35287.64712352843, 42246.366304506075, 43406.78296608497, 43658.781706091264, 43790.0, 45158.0, 31086.533701994034, 31549.8422507886, 32117.197070073435, 32511.0, 33507.162320942174, 31141.065768026994, 32578.348433031682, 33241.0, 33478.665213348526, 33802.66197337995, 35937.82031089828, 36950.63049369472, 37101.44347834839, 38026.42960355652, 38602.80698596489, 27994.86002569974, 29839.403211935205, 30209.0, 30491.695083048886, 30701.53947690831, 23434.296971090895, 24739.154997175556, 24902.12842550502, 25421.61867571951, 25720.742792572582], "value": 16791.27160447285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.9366422861369, 564.074917135897, 564.559643478087, 571.5770329955832, 605.2222893581747, 22075.779242207573, 22915.77084229157, 22920.0, 22983.540329193405, 23008.65487017694, 24712.0, 25620.74379256207, 26940.0, 27200.183994480198, 27206.863965680142, 6484.1894763154605, 6619.635920024397, 6623.403893649571, 6645.9003114953075, 6653.866922661544, 6576.901346479806, 6608.2730899601, 6650.201975762915, 6680.498962577802, 6681.465482761391, 6131.816045518642, 6253.874922501547, 6369.8407539811415, 6475.935240647604, 6628.867422651544, 6524.543281970264, 6552.049952756847, 6572.07990881277, 6577.901331480031, 6587.73649054042, 6100.7254673539355, 6121.693915304217, 6134.9386506134815, 6139.1712118863825, 6165.7533698652, 26907.46185076307, 28829.0, 28921.276968075756, 29218.853905730335, 29226.853865730536, 1876.3339014649875, 1908.055512521311, 1908.6850669639632, 1916.2718167096414, 1918.5011896906765, 18049.548761281072, 18538.258469661196, 18539.72190417145, 18543.07284635776, 18581.0, 2365.8817059147145, 2366.7633236676365, 2378.750231225714, 2443.511297740459, 2450.914218002379, 121936.39031804784, 127196.0, 128122.718772812, 128164.35917820444, 128633.0, 14018.859811401959, 14553.490627827976, 14839.0, 15269.770953435707, 15730.449434269745, 22936.541269174522, 23077.961491732913, 23194.188203413138, 23314.300570982898, 23371.41571460693, 9697.224222062217, 9756.268279879037, 9835.262355323379, 9960.410293323788, 10032.598696052222, 8881.37830351882, 8934.463932164092, 8982.775430614156, 9027.187553120251, 9129.178373946377, 8876.20114189726, 9190.862137067948, 9243.90756092444, 9276.165145136834, 9300.906990930003, 2566.576514875062, 2676.2774051006118, 2704.3104008478103, 2782.234885406489, 2880.3807181456086, 930.5207817973749, 937.105064663245, 950.1116456113556, 998.5007496251874, 1003.2876657573205, 19396.903015484833, 19916.506262030405, 19999.800002000084, 20406.0, 20505.2823151189, 961.1829944547219, 975.3611384543135, 999.5452069308448, 1008.7780688248573, 1021.116734025063, 10651.467426628638, 10879.619213327655, 10939.83590246147, 11045.226834121695, 11138.10895128404, 419094.0, 448521.0, 453673.0, 461910.0, 465003.0, 109472.4526377363, 113246.0, 114770.0, 114785.42607287077, 114857.42571287257, 1162.4331749700016, 1182.1724792645182, 1217.2209785737136, 1228.121892846619, 1236.6537369536545, 19339.4198174055, 21204.939753012597, 21633.13467461284, 21955.890220548794, 21958.670619941033, 51603.0, 54319.0, 54324.72837635787, 54662.453375467325, 55668.721656391455, 67737.66131169313, 68240.6587967057, 68527.3147268521, 69873.65063174651, 70287.29712702807, 12832.358382081045, 12933.159344642945, 12967.0, 12970.416331264927, 13005.089643724848, 18156.092195390444, 18390.172442239862, 18792.906035469736, 18923.716144258124, 18958.905205473886, 14254.501092461715, 15075.773863391838, 15115.470958516398, 15310.38758449694, 15466.458673946358, 12876.0, 13002.479900803863, 13339.333033348488, 13577.660558486117, 13811.792823107862, 15971.28129234164, 16437.83562164363, 17128.143592820557, 17356.305747769948, 17390.739138912675, 17602.559936001704, 17910.10449477547, 18068.0, 18098.185581649122, 18170.0, 15674.9216253918, 16060.759088613913, 16348.10085445312, 16459.67080658404, 16547.66904661876], "value": 11615.952440858202, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.527665317139, 1404.59968908861, 1420.3608376230693, 1424.7577911755, 1429.1782225220502, 13197.736045279089, 13746.450141994308, 13768.311584420764, 13808.240546769923, 13846.10000349979, 13767.311634418289, 13897.444102235924, 13988.790168147487, 14019.088759230643, 14046.64883377916, 2625.750553697396, 2640.986795066022, 2659.2421159969413, 2669.145873320538, 2670.492606404787, 2540.961885571718, 2582.19951814938, 2585.28904551249, 2594.662693849797, 2600.375909781658, 2520.6471094046847, 2530.127106148376, 2563.47448773002, 2564.064116597438, 2567.79457643389, 2477.603583426643, 2492.015653816741, 2494.451220731436, 2499.5000999800113, 2504.949901001979, 2412.0954642009247, 2417.673614062114, 2423.3578101803037, 2451.4851881104987, 2454.4232105455203, 13197.406116724771, 13566.59300220995, 13568.0, 13579.388927498287, 13583.796243056264, 7320.414366850639, 7563.924360756377, 7595.696172153107, 7603.201663825274, 7610.695572177106, 4111.938320925188, 4262.531121576624, 4366.973761166123, 4376.803043863034, 4391.912161756747, 1581.7627355896593, 1617.8463046010727, 1627.5686942960126, 1670.3986564836648, 1672.8828981971267, 19464.70802937957, 20158.29445969399, 21747.13011479539, 21782.0, 22007.0, 5517.972410137923, 5702.6293290935955, 6280.0, 6379.681015949184, 6533.901991470132, 14761.630959226106, 14773.92613036928, 14811.555653330417, 14814.333354998835, 14827.629309267355, 7085.610291434021, 7195.316444937723, 7221.061262036007, 7224.927750722531, 7227.205007449176, 6777.796666100025, 6845.726170953106, 6848.657567121624, 6849.0, 6893.241743408221, 4834.540718631724, 5016.799328026911, 5037.168867136955, 5038.294638750578, 5059.924101138412, 1453.4840131753288, 1496.85779850914, 1506.7815166800754, 1523.124203582922, 1527.0608575726071, 903.7650210945202, 905.117510427328, 907.5280853955906, 924.177482040984, 942.0391200974967, 7098.680559374738, 7394.963025184839, 7592.582407967615, 8613.440126391764, 8754.51850148248, 987.0474991633108, 1000.0249756487367, 1018.2464975917768, 1034.6068493972393, 1037.5008113276394, 5026.698398096126, 5084.949150508522, 5414.214938833847, 5426.267453893753, 5475.564792518073, 18204.45386638403, 18805.0, 19023.429297121107, 19039.714404283946, 19071.80928190728, 18311.81688183101, 18442.262309507736, 18449.53876153107, 18554.628907421775, 18594.070296485123, 9490.762730931643, 9912.306138570375, 10163.136133428594, 10194.694159175087, 10278.074973252295, 8063.314618257514, 8106.797330066795, 8323.41736078493, 8341.916580834357, 8567.528785916835, 15353.155576443403, 15650.843491565394, 15923.52229433119, 16190.271437785092, 16236.26936787871, 15885.364585416915, 16050.357985680908, 16245.187740612686, 16406.343746250015, 16414.507564773077, 11011.779764404508, 11067.557297708001, 11263.0, 11318.886811132114, 11560.0, 12691.619251422471, 12843.0, 12847.807282890952, 12864.163829351062, 12898.226106433644, 10077.949610251902, 10181.643642472774, 10403.583856645952, 10584.206184536037, 10804.783904322027, 9651.131398174199, 10011.499425028866, 10061.949690251795, 10109.191264698953, 10217.284790064625, 9344.299177561847, 9527.57125929321, 9548.570314335733, 9552.42685438876, 9593.712188634352, 6569.178852643419, 6607.669616519059, 6692.130023096966, 6815.625140617115, 6878.65606719672, 7158.950432667476, 7347.632618369167, 7436.59098749574, 7497.062867141607, 7584.317411432777], "value": 6175.34318490802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.1124286341677, 499.1514425476689, 499.5828483216514, 516.4035538952506, 525.723994902676, 6246.875062498753, 6270.184875966118, 6290.685465726707, 6338.397852204033, 6346.365363463657, 5946.940530594693, 6108.328083910777, 6171.105189747495, 6187.412195841399, 6207.317195108534, 4898.730569818658, 4912.838351125502, 4940.703557786526, 4945.381827271591, 4953.950460495403, 4911.607071434277, 4927.2855435961765, 4945.208766597345, 4961.429435614897, 4970.0, 4931.65478416511, 4946.802127914879, 4960.578350840183, 4968.627352948525, 4971.353724015873, 4726.432828060638, 4870.342503761982, 4888.437829649601, 4914.385701787277, 4914.459409464956, 4380.123975204971, 4402.955970440286, 4407.294832826732, 4431.446069241345, 4435.512093669726, 5994.460498555108, 6022.187004754346, 6022.2171117754415, 6042.395760423967, 6045.3047899491685, 5530.5852061095575, 5592.4407559244155, 5597.944020559783, 5604.411536788619, 5621.156826476021, 6515.576487528296, 6530.869382612369, 6548.869022619521, 6567.835804104888, 6627.602343859384, 4771.570558649738, 4845.903081938377, 4846.806127754886, 4864.148773964577, 4882.829100981484, 6815.522913396015, 6885.862282754317, 6902.723891044352, 6919.8962015569805, 6963.67690138872, 4961.131801934647, 4962.156433406258, 4980.8754781130765, 4991.376077990251, 5015.598752099823, 5006.224035274538, 5044.167712327425, 5054.570361519239, 5057.494250574913, 5062.7215503146945, 5644.520215781705, 5653.717314134359, 5682.289713785777, 5688.658680479184, 5697.857553561194, 6622.437092847065, 6626.83432914181, 6630.138082049302, 6671.366220209073, 6702.229243637044, 1631.282235816237, 1750.571110078039, 1755.1926113987454, 1757.4903278049478, 1770.9557261068576, 1222.3460448659923, 1225.5526732742485, 1227.5142835757663, 1233.8334324866028, 1244.3094082784141, 5584.720763961785, 5741.511971482387, 5747.3103227612955, 5789.986752318412, 5810.854728631733, 6603.339666033455, 6736.797896063126, 6747.392734653807, 6748.527603067836, 6761.256261811197, 5732.503173064428, 5739.8852022960145, 5747.770089196385, 5751.654900705971, 5767.653940763567, 3568.7858728475853, 3576.070221742366, 3581.731370147197, 3587.5694916610173, 3594.8562057517406, 6531.314212007671, 6550.70521826519, 6553.311902250291, 6554.3117972613145, 6556.246031706415, 6818.624975626388, 6901.756174597931, 6907.654617269116, 6917.965410172917, 6930.099087118743, 6527.184101987252, 6538.215414150237, 6545.0, 6551.594934179226, 6570.967145164243, 6727.663616819042, 6734.427573656294, 6738.831529211809, 6746.730130794714, 6766.96616516934, 6583.80248592543, 6609.239937407259, 6649.135612370555, 6656.866862662817, 6662.233843107911, 6284.151639528605, 6516.674166291572, 6517.4134327910715, 6547.770828020996, 6571.5399922005, 4905.337779399735, 4915.410150781929, 4931.580815630568, 4947.282644016525, 4961.677490963076, 6659.467242620482, 6685.323072310112, 6690.765823196165, 6693.866122677422, 6767.627780471925, 6456.0, 6470.5147113965695, 6511.446527045254, 6525.06219340398, 6543.1821022372205, 6518.837029074311, 6534.4772418205475, 6543.476521878143, 6544.869102618016, 6561.507886908405, 6447.323695839022, 6455.61266324022, 6458.935410646021, 6466.612003279818, 6495.408624886933, 6559.704813283509, 6587.176602924635, 6588.374104460068, 6599.307072757291, 6633.966830166011, 6397.712102955471, 6405.711742971671, 6406.967965160145, 6408.58344207625, 6409.8718025640155], "value": 5041.584860637285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.3896635972563, 860.0324634785866, 865.4763867859945, 870.6778491957973, 877.7761670773949, 17484.125793710296, 17502.91248543757, 17929.10354482277, 18018.5495362616, 18062.277508899628, 18693.34573289935, 20280.492987675316, 20668.06993685284, 20725.792742072612, 20876.58246835066, 1023.1507848485776, 1044.8328267477204, 1045.7594753206768, 1046.7906418716286, 1051.1538211739546, 1047.6909311753013, 1047.9423631700254, 1048.7220886465093, 1049.2864851900742, 1050.5220124843215, 1032.958681652733, 1110.3005106782755, 1112.5216157052464, 1115.1469126118525, 1117.5027112934747, 1078.471548941017, 1083.7290677330668, 1083.815751322277, 1085.478970094359, 1087.34215799441, 791.0665414810579, 795.2802713544252, 797.9760607181794, 798.6206551887865, 800.131856935226, 18126.456206313833, 18313.816861831343, 18649.067546622613, 18759.624807503773, 18767.0, 18299.268029278945, 18593.44219673412, 18643.533911652183, 18678.25286988519, 19034.33379831699, 15268.16025118618, 15287.464938727091, 15395.461158859498, 15423.845761542354, 15553.844461555353, 3456.1532424555894, 3494.545709057806, 3584.193556449778, 3619.5294611700574, 3634.545681789776, 100787.0, 102476.0, 103044.48477757638, 103816.48091759493, 105794.47102764514, 14722.116672999655, 14882.851171488363, 15009.924950375178, 15035.699286014218, 15073.924630376778, 26858.5971210432, 27321.453570928472, 27747.0, 27929.301767455978, 28045.57931631027, 8037.276645101969, 8317.792055198548, 8398.538080405515, 8411.957940210383, 8430.494170349799, 3872.7289089763444, 3934.5475270343704, 3944.0928586425284, 3946.644801967837, 3956.149427873021, 4873.41519017713, 4930.33440485537, 5229.555487783505, 5442.2108794225405, 5496.5053145217125, 865.0700496965787, 902.3232575568323, 903.7108125399809, 1012.5949620151998, 1028.573142146016, 603.3664652115261, 663.3068443476578, 683.6376720338229, 684.2815044203567, 712.383788023356, 10357.792844143074, 10364.533595988049, 10494.370337779757, 10686.465676716132, 11128.165387595962, 682.3279070115932, 688.9517733758589, 689.300360134464, 690.9481788865855, 712.9839978031284, 4871.488493708181, 4913.164761990471, 4993.675411098267, 5079.822206222764, 5101.642884998015, 86380.0, 86546.56726716452, 89814.0, 91802.08197917935, 92736.0, 86268.0, 87452.0, 88037.0, 89714.55142724245, 91768.54115729513, 70671.6466417675, 71374.0, 71420.28579714136, 74002.62998685079, 75586.86619700708, 9574.473403962571, 9687.903120968982, 9894.752631184278, 10200.132988696045, 10236.897631023594, 31628.0, 32672.673273266962, 33263.83368083144, 33490.497642534894, 34291.65708342985, 42108.368374473794, 43268.78365608152, 43422.56577434185, 43526.782366087966, 43989.12021759611, 13763.0, 13771.311434428038, 13799.51701690436, 13820.0, 13948.511802087283, 13738.313084345942, 14054.929725351309, 14060.789088163481, 14099.365528551034, 14294.356753945889, 12632.936835315764, 13362.465501379836, 13540.119892206974, 13699.246541440316, 13702.725945481234, 11751.882481175078, 11825.704357391134, 11927.940360298144, 12042.518299267931, 12045.81931271014, 12971.416286266953, 13472.932635336761, 13571.728565428439, 13619.18284902909, 13642.0, 9860.901390986286, 10547.156227501935, 10748.623798167027, 10888.51001704941, 10956.616518421817, 10722.517486713272, 10944.945275273572, 11059.944700276446, 11262.267952583055, 11275.436228188722], "value": 8051.532017668822, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 108.0, 107.0, 116.0, 107.0, 108.0, 108.0, 108.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 122.0, 147.0, 169.0, 121.0, 151.0, 150.0, 130.0, 172.0, 120.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 161.0, 163.0, 169.0, 164.0, 163.0, 167.0, 166.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 163.0, 76.0, 75.0, 74.0, 74.0, 95.0, 76.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 148.0, 81.0, 82.0, 81.0, 129.0, 81.0, 81.0, 136.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 150.0, 151.0, 149.0, 150.0, 151.0, 153.0, 150.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 59.0, 54.0, 53.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 78.0, 77.0, 76.0, 76.0, 84.0, 77.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 127.0, 139.0, 136.0, 134.0, 131.0, 124.0, 132.0, 155.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 199.0, 185.0, 186.0, 186.0, 188.0, 187.0, 183.0, 194.0, 183.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 67.0, 68.0, 69.0, 68.0, 71.0, 72.0, 71.0], "value": 69.3, "unit": "score"}]}]} 05:31:44 INFO - Return code: 0 05:31:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:44 INFO - # TBPL SUCCESS # 05:31:44 INFO - Running post-action listener: _resource_record_post_action 05:31:44 INFO - [mozharness: 2017-06-26 12:31:44.168830Z] Finished run-tests step (success) 05:31:44 INFO - Running post-run listener: _resource_record_post_run 05:31:44 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 5525504; Write bytes: 446226432; Read time: 1484; Write time: 529048 05:31:44 INFO - TinderboxPrint: CPU usage
13.1% 05:31:44 INFO - TinderboxPrint: I/O read bytes / time
5,525,504 / 1,484 05:31:44 INFO - TinderboxPrint: I/O write bytes / time
446,226,432 / 529,048 05:31:44 INFO - TinderboxPrint: CPU idle
8,320.4 (86.9%) 05:31:44 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 05:31:44 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:44 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 118038528; Read time: 84; Write time: 121600 05:31:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:31:44 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 3330048; Write bytes: 285507584; Read time: 1012; Write time: 381760 05:31:44 INFO - Running post-run listener: _upload_blobber_files 05:31:44 INFO - Blob upload gear active. 05:31:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:44 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 05:31:44 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'] 05:31:44 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 05:31:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:46 INFO - (blobuploader) - INFO - Done attempting. 05:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:47 INFO - (blobuploader) - INFO - Done attempting. 05:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:50 INFO - (blobuploader) - INFO - Done attempting. 05:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:51 INFO - (blobuploader) - INFO - Done attempting. 05:31:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:51 INFO - Return code: 0 05:31:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316c872a42d2d54c336cfea8e7d6c1d0500162e1941578f018f9018006a26083ae46b57b1c68d15764bf50f370daddaa5314f5f72d82ecaff13513071f2442ff", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561780a4cc4d0710ba3bcf14e7cbd518ea3b8b3722ef495d6fe64e3f39a9c52c7cc2acafdc01fc3af69466a51750122dd3b140e105445a1c615da705e8ff3029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59ab1a97998c3995b07b347123ccd904241828894925d8417e7ff90d71b5cad18d3e613f19132956cab37d8539132bca8c62cddccda995c08a6d5900a007ee2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5b36fdeda7df9f0ccb629bc7909850d2135061268def3e29881749aa570c9c7bc6d704d3c70c16870d3f28615d5878cced31264b702f243fb2a8c2500bdb2a7"} 05:31:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:51 INFO - Contents: 05:31:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316c872a42d2d54c336cfea8e7d6c1d0500162e1941578f018f9018006a26083ae46b57b1c68d15764bf50f370daddaa5314f5f72d82ecaff13513071f2442ff", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561780a4cc4d0710ba3bcf14e7cbd518ea3b8b3722ef495d6fe64e3f39a9c52c7cc2acafdc01fc3af69466a51750122dd3b140e105445a1c615da705e8ff3029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59ab1a97998c3995b07b347123ccd904241828894925d8417e7ff90d71b5cad18d3e613f19132956cab37d8539132bca8c62cddccda995c08a6d5900a007ee2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5b36fdeda7df9f0ccb629bc7909850d2135061268def3e29881749aa570c9c7bc6d704d3c70c16870d3f28615d5878cced31264b702f243fb2a8c2500bdb2a7"} 05:31:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:51 INFO - Copying logs to upload dir... 05:31:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.690307 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-06-26 05:31:51.021085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-26 05:31:51.025893) ========= 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=836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977 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/316c872a42d2d54c336cfea8e7d6c1d0500162e1941578f018f9018006a26083ae46b57b1c68d15764bf50f370daddaa5314f5f72d82ecaff13513071f2442ff", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561780a4cc4d0710ba3bcf14e7cbd518ea3b8b3722ef495d6fe64e3f39a9c52c7cc2acafdc01fc3af69466a51750122dd3b140e105445a1c615da705e8ff3029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59ab1a97998c3995b07b347123ccd904241828894925d8417e7ff90d71b5cad18d3e613f19132956cab37d8539132bca8c62cddccda995c08a6d5900a007ee2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5b36fdeda7df9f0ccb629bc7909850d2135061268def3e29881749aa570c9c7bc6d704d3c70c16870d3f28615d5878cced31264b702f243fb2a8c2500bdb2a7"} build_url:https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/KYnvssSNQEev-CA0uoM8ww/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/316c872a42d2d54c336cfea8e7d6c1d0500162e1941578f018f9018006a26083ae46b57b1c68d15764bf50f370daddaa5314f5f72d82ecaff13513071f2442ff", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/561780a4cc4d0710ba3bcf14e7cbd518ea3b8b3722ef495d6fe64e3f39a9c52c7cc2acafdc01fc3af69466a51750122dd3b140e105445a1c615da705e8ff3029", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59ab1a97998c3995b07b347123ccd904241828894925d8417e7ff90d71b5cad18d3e613f19132956cab37d8539132bca8c62cddccda995c08a6d5900a007ee2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5b36fdeda7df9f0ccb629bc7909850d2135061268def3e29881749aa570c9c7bc6d704d3c70c16870d3f28615d5878cced31264b702f243fb2a8c2500bdb2a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-26 05:31:51.052916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:31:51.053291) ========= 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=836cfdc75598d54cb747368e000001a9-1498469695.239943-568120977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004340 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:31:51.133259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-26 05:31:51.136723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-26 05:31:51.137111) ========= ========= Total master_lag: 0.18 =========