builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1496072756.52 results: success (0) revision: 34ac1a5d6576d6775491c8a882710a1520551da6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.524951) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.525405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.525692) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.563326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.563604) ========= 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=db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-29 08:45:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2017-05-29 08:45:57 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.195115 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.771710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.775053) ========= 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=db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022267 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.826420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:56.826774) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34ac1a5d6576d6775491c8a882710a1520551da6 --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 34ac1a5d6576d6775491c8a882710a1520551da6 --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=db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-29 08:45:57,540 truncating revision to first 12 chars 2017-05-29 08:45:57,540 Setting DEBUG logging. 2017-05-29 08:45:57,540 attempt 1/10 2017-05-29 08:45:57,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34ac1a5d6576?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-29 08:45:58,018 unpacking tar archive at: mozilla-central-34ac1a5d6576/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789699 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:57.629028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:57.629315) ========= script_repo_revision: 34ac1a5d6576d6775491c8a882710a1520551da6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:57.629671) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:57.634995) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-29 08:45:57.644530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-29 08:45:57.644805) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:45:58 INFO - MultiFileLogger online at 20170529 08:45:58 in /builds/slave/test 08:45:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:45:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:58 INFO - {'append_to_log': False, 08:45:58 INFO - 'base_work_dir': '/builds/slave/test', 08:45:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:45:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:58 INFO - 'branch': 'Firefox-Non-PGO', 08:45:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:58 INFO - 'config_files': ('talos/linux_config.py',), 08:45:58 INFO - 'default_actions': ('clobber', 08:45:58 INFO - 'read-buildbot-config', 08:45:58 INFO - 'download-and-extract', 08:45:58 INFO - 'populate-webroot', 08:45:58 INFO - 'create-virtualenv', 08:45:58 INFO - 'install', 08:45:58 INFO - 'setup-mitmproxy', 08:45:58 INFO - 'run-tests'), 08:45:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:58 INFO - 'download_minidump_stackwalk': True, 08:45:58 INFO - 'download_symbols': 'ondemand', 08:45:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:58 INFO - 'gecko_profile': False, 08:45:58 INFO - 'gecko_profile_interval': 0, 08:45:58 INFO - 'installer_path': 'installer.exe', 08:45:58 INFO - 'log_level': 'info', 08:45:58 INFO - 'log_name': 'talos', 08:45:58 INFO - 'log_to_console': True, 08:45:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:45:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:45:58 INFO - 'opt_config_files': (), 08:45:58 INFO - 'pip_index': False, 08:45:58 INFO - 'suite': 'dromaeojs-e10s', 08:45:58 INFO - 'system_bits': '32', 08:45:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:58 INFO - 'title': 'talos-linux64-ix-049', 08:45:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:58 INFO - 'use_talos_json': True, 08:45:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:58 INFO - 'work_dir': 'build'} 08:45:58 INFO - [mozharness: 2017-05-29 15:45:58.465995Z] Running clobber step. 08:45:58 INFO - Running pre-action listener: _resource_record_pre_action 08:45:58 INFO - Running main action method: clobber 08:45:58 INFO - rmtree: /builds/slave/test/build 08:45:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:00 INFO - Running post-action listener: _resource_record_post_action 08:46:00 INFO - [mozharness: 2017-05-29 15:46:00.018638Z] Finished clobber step (success) 08:46:00 INFO - [mozharness: 2017-05-29 15:46:00.018738Z] Running read-buildbot-config step. 08:46:00 INFO - Running pre-action listener: _resource_record_pre_action 08:46:00 INFO - Running main action method: read_buildbot_config 08:46:00 INFO - Using buildbot properties: 08:46:00 INFO - { 08:46:00 INFO - "project": "", 08:46:00 INFO - "product": "firefox", 08:46:00 INFO - "who": "ffxbld@noreply.mozilla.org", 08:46:00 INFO - "installer_path": "public/build/target.tar.bz2", 08:46:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:46:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:46:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:46:00 INFO - "stage_platform": "linux64", 08:46:00 INFO - "basedir": "/builds/slave/test", 08:46:00 INFO - "buildnumber": 864, 08:46:00 INFO - "platform": "ubuntu64_hw", 08:46:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:46:00 INFO - "slavebuilddir": "test", 08:46:00 INFO - "taskId": "FFjGFGAiTGaB8V6FoBpbSA", 08:46:00 INFO - "branch": "mozilla-central", 08:46:00 INFO - "script_repo_revision": "production", 08:46:00 INFO - "revision": "34ac1a5d6576d6775491c8a882710a1520551da6", 08:46:00 INFO - "slavename": "talos-linux64-ix-049", 08:46:00 INFO - "repo_path": "mozilla-central" 08:46:00 INFO - } 08:46:00 INFO - Finding installer, test and symbols from parent task. 08:46:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFjGFGAiTGaB8V6FoBpbSA'}, attempt #1 08:46:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FFjGFGAiTGaB8V6FoBpbSA'}, attempt #1 08:46:00 INFO - Task dependencies: YJcJi7eESraDPq_UXv8bJQ 08:46:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ'}, attempt #1 08:46:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2 08:46:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/test_packages.json 08:46:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.crashreporter-symbols.zip 08:46:01 INFO - Running post-action listener: _resource_record_post_action 08:46:01 INFO - [mozharness: 2017-05-29 15:46:01.426633Z] Finished read-buildbot-config step (success) 08:46:01 INFO - [mozharness: 2017-05-29 15:46:01.426853Z] Running download-and-extract step. 08:46:01 INFO - Running pre-action listener: _resource_record_pre_action 08:46:01 INFO - Running main action method: download_and_extract 08:46:01 INFO - mkdir: /builds/slave/test/build/tests 08:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:01 INFO - trying https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.test_packages.json 08:46:01 INFO - Downloading https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:46:01 INFO - Downloaded 986 bytes. 08:46:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:46:01 INFO - Using the following test package requirements: 08:46:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:46:01 INFO - u'common': [u'target.common.tests.zip'], 08:46:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:46:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:46:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:46:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:46:01 INFO - u'mozbase': [u'target.common.tests.zip'], 08:46:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:46:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:46:01 INFO - u'web-platform': [u'target.common.tests.zip', 08:46:01 INFO - u'target.web-platform.tests.zip'], 08:46:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:46:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:46:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.common.tests.zip 08:46:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:01 INFO - Fetch https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.common.tests.zip into memory 08:46:03 INFO - Content-Length response header: 63527381 08:46:03 INFO - Bytes received: 63527381 08:46:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:46:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.common.tests.zip 08:46:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:46:14 INFO - Fetch https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.common.tests.zip into memory 08:46:15 INFO - Content-Length response header: 63527381 08:46:15 INFO - Bytes received: 63527381 08:46:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.talos.tests.zip 08:46:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:46:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.talos.tests.zip into memory 08:46:27 INFO - Content-Length response header: 14447425 08:46:27 INFO - Bytes received: 14447425 08:46: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')]} 08:46:28 INFO - trying https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2 08:46:28 INFO - Downloading https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:46:29 INFO - Downloaded 54140483 bytes. 08:46:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2 08:46:29 INFO - mkdir: /builds/slave/test/properties 08:46:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:29 INFO - Contents: 08:46:29 INFO - build_url:https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2 08:46:29 INFO - Running post-action listener: _resource_record_post_action 08:46:29 INFO - Running post-action listener: set_extra_try_arguments 08:46:29 INFO - [mozharness: 2017-05-29 15:46:29.199738Z] Finished download-and-extract step (success) 08:46:29 INFO - [mozharness: 2017-05-29 15:46:29.199834Z] Running populate-webroot step. 08:46:29 INFO - Running pre-action listener: _resource_record_pre_action 08:46:29 INFO - Running main action method: populate_webroot 08:46:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:29 INFO - '--tppagecycles', 08:46:29 INFO - '7'], 08:46:29 INFO - 'tests': ['tsvgm']}}, 08:46:29 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['damp', 'tps']}, 08:46:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'tests': ['damp', 'tps']}, 08:46:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['dromaeo_dom']}, 08:46:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:46:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:46:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:46:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['a11yr', 08:46:29 INFO - 'ts_paint', 08:46:29 INFO - 'tpaint', 08:46:29 INFO - 'sessionrestore', 08:46:29 INFO - 'sessionrestore_no_auto_restore', 08:46:29 INFO - 'tabpaint']}, 08:46:29 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:29 INFO - 'ts_paint', 08:46:29 INFO - 'tpaint', 08:46:29 INFO - 'sessionrestore', 08:46:29 INFO - 'sessionrestore_no_auto_restore', 08:46:29 INFO - 'tabpaint']}, 08:46:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:29 INFO - 'ts_paint', 08:46:29 INFO - 'tpaint', 08:46:29 INFO - 'sessionrestore', 08:46:29 INFO - 'sessionrestore_no_auto_restore', 08:46:29 INFO - 'tabpaint']}, 08:46:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:29 INFO - 'ts_paint', 08:46:29 INFO - 'tpaint', 08:46:29 INFO - 'sessionrestore', 08:46:29 INFO - 'sessionrestore_no_auto_restore', 08:46:29 INFO - 'tabpaint']}, 08:46:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['a11yr', 08:46:29 INFO - 'ts_paint', 08:46:29 INFO - 'tpaint', 08:46:29 INFO - 'sessionrestore', 08:46:29 INFO - 'sessionrestore_no_auto_restore', 08:46:29 INFO - 'tabpaint']}, 08:46:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['a11yr', 08:46:29 INFO - 'ts_paint', 08:46:29 INFO - 'tpaint', 08:46:29 INFO - 'sessionrestore', 08:46:29 INFO - 'sessionrestore_no_auto_restore', 08:46:29 INFO - 'tabpaint']}, 08:46:29 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:46:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:46:29 INFO - 'bloom_basic_ref']}, 08:46:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:46:29 INFO - 'talos_options': ['--mitmproxy', 08:46:29 INFO - 'mitmproxy-recording-1.mp', 08:46:29 INFO - '--firstNonBlankPaint'], 08:46:29 INFO - 'tests': ['Quantum_1']}, 08:46:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['tsvgx', 08:46:29 INFO - 'tsvgr_opacity', 08:46:29 INFO - 'tart', 08:46:29 INFO - 'tscrollx', 08:46:29 INFO - 'cart', 08:46:29 INFO - 'tsvg_static']}, 08:46:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:29 INFO - 'tsvgr_opacity', 08:46:29 INFO - 'tart', 08:46:29 INFO - 'tscrollx', 08:46:29 INFO - 'cart', 08:46:29 INFO - 'tsvg_static']}, 08:46:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'talos_options': ['--disable-e10s'], 08:46:29 INFO - 'tests': ['tp5o']}, 08:46:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:46:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'talos_options': ['--disable-e10s', 08:46:29 INFO - '--xperf_path', 08:46:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:29 INFO - 'tests': ['tp5n']}, 08:46:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:46:29 INFO - 'talos_options': ['--xperf_path', 08:46:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:29 INFO - 'tests': ['tp5n']}}, 08:46:29 INFO - 'talos.zip': {'path': '', 08:46:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:29 INFO - Running post-action listener: _resource_record_post_action 08:46:29 INFO - [mozharness: 2017-05-29 15:46:29.214110Z] Finished populate-webroot step (success) 08:46:29 INFO - [mozharness: 2017-05-29 15:46:29.214204Z] Running create-virtualenv step. 08:46:29 INFO - Running pre-action listener: _resource_record_pre_action 08:46:29 INFO - Running main action method: create_virtualenv 08:46:29 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:46:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:29 INFO - Using real prefix '/usr' 08:46:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:31 INFO - Installing pip.................done. 08:46:31 INFO - Return code: 0 08:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:32 INFO - Reading from file tmpfile_stdout 08:46:32 INFO - Output received: 08:46:32 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) 08:46:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46: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', 'pip>=1.5'] in /builds/slave/test/build 08:46: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 pip>=1.5 08:46:32 INFO - Using env: {'DISPLAY': ':0', 08:46:32 INFO - 'HOME': '/home/cltbld', 08:46:32 INFO - 'LANG': 'en_US.UTF-8', 08:46:32 INFO - 'LANGUAGE': 'en_US:en', 08:46:32 INFO - 'LOGNAME': 'cltbld', 08:46:32 INFO - 'MAIL': '/var/mail/cltbld', 08:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:32 INFO - 'MOZ_NO_REMOTE': '1', 08:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:32 INFO - 'NO_EM_RESTART': '1', 08:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:32 INFO - 'PWD': '/builds/slave/test', 08:46:32 INFO - 'SHELL': '/bin/bash', 08:46:32 INFO - 'SHLVL': '1', 08:46:32 INFO - 'TERM': 'linux', 08:46:32 INFO - 'TMOUT': '86400', 08:46:32 INFO - 'USER': 'cltbld', 08:46:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:32 INFO - '_': '/tools/buildbot/bin/python'} 08:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:46:32 INFO - Cleaning up... 08:46:32 INFO - Return code: 0 08:46:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:46:32 INFO - Using env: {'DISPLAY': ':0', 08:46:32 INFO - 'HOME': '/home/cltbld', 08:46:32 INFO - 'LANG': 'en_US.UTF-8', 08:46:32 INFO - 'LANGUAGE': 'en_US:en', 08:46:32 INFO - 'LOGNAME': 'cltbld', 08:46:32 INFO - 'MAIL': '/var/mail/cltbld', 08:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:32 INFO - 'MOZ_NO_REMOTE': '1', 08:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:32 INFO - 'NO_EM_RESTART': '1', 08:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:32 INFO - 'PWD': '/builds/slave/test', 08:46:32 INFO - 'SHELL': '/bin/bash', 08:46:32 INFO - 'SHLVL': '1', 08:46:32 INFO - 'TERM': 'linux', 08:46:32 INFO - 'TMOUT': '86400', 08:46:32 INFO - 'USER': 'cltbld', 08:46:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:32 INFO - '_': '/tools/buildbot/bin/python'} 08:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:32 INFO - Downloading/unpacking psutil>=3.1.1 08:46: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 08:46: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 08:46: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 08:46: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 08:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:33 INFO - Installing collected packages: psutil 08:46:33 INFO - Running setup.py install for psutil 08:46:33 INFO - building 'psutil._psutil_linux' extension 08:46:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:46:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:46:33 INFO - building 'psutil._psutil_posix' extension 08:46:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:46:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:46:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:34 INFO - Successfully installed psutil 08:46:34 INFO - Cleaning up... 08:46:34 INFO - Return code: 0 08:46:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:46:34 INFO - Using env: {'DISPLAY': ':0', 08:46:34 INFO - 'HOME': '/home/cltbld', 08:46:34 INFO - 'LANG': 'en_US.UTF-8', 08:46:34 INFO - 'LANGUAGE': 'en_US:en', 08:46:34 INFO - 'LOGNAME': 'cltbld', 08:46:34 INFO - 'MAIL': '/var/mail/cltbld', 08:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:34 INFO - 'MOZ_NO_REMOTE': '1', 08:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:34 INFO - 'NO_EM_RESTART': '1', 08:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:34 INFO - 'PWD': '/builds/slave/test', 08:46:34 INFO - 'SHELL': '/bin/bash', 08:46:34 INFO - 'SHLVL': '1', 08:46:34 INFO - 'TERM': 'linux', 08:46:34 INFO - 'TMOUT': '86400', 08:46:34 INFO - 'USER': 'cltbld', 08:46:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:34 INFO - '_': '/tools/buildbot/bin/python'} 08:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:35 INFO - Installing collected packages: mozsystemmonitor 08:46:35 INFO - Running setup.py install for mozsystemmonitor 08:46:35 INFO - Successfully installed mozsystemmonitor 08:46:35 INFO - Cleaning up... 08:46:35 INFO - Return code: 0 08:46:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:46:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:46:35 INFO - Using env: {'DISPLAY': ':0', 08:46:35 INFO - 'HOME': '/home/cltbld', 08:46:35 INFO - 'LANG': 'en_US.UTF-8', 08:46:35 INFO - 'LANGUAGE': 'en_US:en', 08:46:35 INFO - 'LOGNAME': 'cltbld', 08:46:35 INFO - 'MAIL': '/var/mail/cltbld', 08:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:35 INFO - 'MOZ_NO_REMOTE': '1', 08:46:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:35 INFO - 'NO_EM_RESTART': '1', 08:46:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:35 INFO - 'PWD': '/builds/slave/test', 08:46:35 INFO - 'SHELL': '/bin/bash', 08:46:35 INFO - 'SHLVL': '1', 08:46:35 INFO - 'TERM': 'linux', 08:46:35 INFO - 'TMOUT': '86400', 08:46:35 INFO - 'USER': 'cltbld', 08:46:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:35 INFO - '_': '/tools/buildbot/bin/python'} 08:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:37 INFO - warning: no files found matching '*.txt' 08:46:37 INFO - no previously-included directories found matching 'build' 08:46:37 INFO - no previously-included directories found matching 'dist' 08:46:37 INFO - no previously-included directories found matching '.git*' 08:46:37 INFO - Installing collected packages: jsonschema, functools32 08:46:37 INFO - Running setup.py install for functools32 08:46:37 INFO - warning: no files found matching '*.txt' 08:46:37 INFO - no previously-included directories found matching 'build' 08:46:37 INFO - no previously-included directories found matching 'dist' 08:46:37 INFO - no previously-included directories found matching '.git*' 08:46:37 INFO - Successfully installed jsonschema functools32 08:46:37 INFO - Cleaning up... 08:46:37 INFO - Return code: 0 08:46:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:46:37 INFO - Using env: {'DISPLAY': ':0', 08:46:37 INFO - 'HOME': '/home/cltbld', 08:46:37 INFO - 'LANG': 'en_US.UTF-8', 08:46:37 INFO - 'LANGUAGE': 'en_US:en', 08:46:37 INFO - 'LOGNAME': 'cltbld', 08:46:37 INFO - 'MAIL': '/var/mail/cltbld', 08:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:37 INFO - 'MOZ_NO_REMOTE': '1', 08:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:37 INFO - 'NO_EM_RESTART': '1', 08:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:37 INFO - 'PWD': '/builds/slave/test', 08:46:37 INFO - 'SHELL': '/bin/bash', 08:46:37 INFO - 'SHLVL': '1', 08:46:37 INFO - 'TERM': 'linux', 08:46:37 INFO - 'TMOUT': '86400', 08:46:37 INFO - 'USER': 'cltbld', 08:46:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:37 INFO - '_': '/tools/buildbot/bin/python'} 08:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:46:37 INFO - Cleaning up... 08:46:37 INFO - Return code: 0 08:46:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:46:37 INFO - Using env: {'DISPLAY': ':0', 08:46:37 INFO - 'HOME': '/home/cltbld', 08:46:37 INFO - 'LANG': 'en_US.UTF-8', 08:46:37 INFO - 'LANGUAGE': 'en_US:en', 08:46:37 INFO - 'LOGNAME': 'cltbld', 08:46:37 INFO - 'MAIL': '/var/mail/cltbld', 08:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:37 INFO - 'MOZ_NO_REMOTE': '1', 08:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:37 INFO - 'NO_EM_RESTART': '1', 08:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:37 INFO - 'PWD': '/builds/slave/test', 08:46:37 INFO - 'SHELL': '/bin/bash', 08:46:37 INFO - 'SHLVL': '1', 08:46:37 INFO - 'TERM': 'linux', 08:46:37 INFO - 'TMOUT': '86400', 08:46:37 INFO - 'USER': 'cltbld', 08:46:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:37 INFO - '_': '/tools/buildbot/bin/python'} 08:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46: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 08:46: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 08:46: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 08:46: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 08:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46: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 08:46: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 08:46: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 08:46: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 08:46:39 INFO - Downloading docopt-0.6.1.tar.gz 08:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:39 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:39 INFO - Running setup.py install for blobuploader 08:46:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:39 INFO - Running setup.py install for requests 08:46:40 INFO - Running setup.py install for docopt 08:46:40 INFO - Successfully installed blobuploader requests docopt 08:46:40 INFO - Cleaning up... 08:46:40 INFO - Return code: 0 08:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46: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')]} 08:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:46:40 INFO - Using env: {'DISPLAY': ':0', 08:46:40 INFO - 'HOME': '/home/cltbld', 08:46:40 INFO - 'LANG': 'en_US.UTF-8', 08:46:40 INFO - 'LANGUAGE': 'en_US:en', 08:46:40 INFO - 'LOGNAME': 'cltbld', 08:46:40 INFO - 'MAIL': '/var/mail/cltbld', 08:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:40 INFO - 'MOZ_NO_REMOTE': '1', 08:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:40 INFO - 'NO_EM_RESTART': '1', 08:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:40 INFO - 'PWD': '/builds/slave/test', 08:46:40 INFO - 'SHELL': '/bin/bash', 08:46:40 INFO - 'SHLVL': '1', 08:46:40 INFO - 'TERM': 'linux', 08:46:40 INFO - 'TMOUT': '86400', 08:46:40 INFO - 'USER': 'cltbld', 08:46:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:40 INFO - '_': '/tools/buildbot/bin/python'} 08:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:40 INFO - Running setup.py (path:/tmp/pip-6l95Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:40 INFO - Running setup.py (path:/tmp/pip-9pA1oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:40 INFO - Running setup.py (path:/tmp/pip-dHV8sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:40 INFO - Running setup.py (path:/tmp/pip-6hK7nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:40 INFO - Running setup.py (path:/tmp/pip-pWUkSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:40 INFO - Running setup.py (path:/tmp/pip-XQOK6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:40 INFO - Running setup.py (path:/tmp/pip-XTOVWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:40 INFO - Running setup.py (path:/tmp/pip-1Wa0kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:41 INFO - Running setup.py (path:/tmp/pip-gyLnAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:41 INFO - Running setup.py (path:/tmp/pip-TMEPsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:41 INFO - Running setup.py (path:/tmp/pip-21Xtej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:41 INFO - Running setup.py (path:/tmp/pip-OexRHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:41 INFO - Running setup.py (path:/tmp/pip-srMRYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:41 INFO - Running setup.py (path:/tmp/pip-uZmeCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:41 INFO - Running setup.py (path:/tmp/pip-1zdFKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:41 INFO - Running setup.py (path:/tmp/pip-8D1Afm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:41 INFO - Running setup.py (path:/tmp/pip-_FF4Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:41 INFO - Running setup.py install for manifestparser 08:46:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:41 INFO - Running setup.py install for mozcrash 08:46:41 INFO - Running setup.py install for mozdebug 08:46:41 INFO - Running setup.py install for mozdevice 08:46:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozfile 08:46:42 INFO - Running setup.py install for mozhttpd 08:46:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozinfo 08:46:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozInstall 08:46:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozleak 08:46:42 INFO - Running setup.py install for mozlog 08:46:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for moznetwork 08:46:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:42 INFO - Running setup.py install for mozprocess 08:46:42 INFO - Running setup.py install for mozprofile 08:46:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:43 INFO - Running setup.py install for mozrunner 08:46:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:43 INFO - Running setup.py install for mozscreenshot 08:46:43 INFO - Running setup.py install for moztest 08:46:43 INFO - Running setup.py install for mozversion 08:46:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:43 INFO - Cleaning up... 08:46:43 INFO - Return code: 0 08:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:46:43 INFO - Using env: {'DISPLAY': ':0', 08:46:43 INFO - 'HOME': '/home/cltbld', 08:46:43 INFO - 'LANG': 'en_US.UTF-8', 08:46:43 INFO - 'LANGUAGE': 'en_US:en', 08:46:43 INFO - 'LOGNAME': 'cltbld', 08:46:43 INFO - 'MAIL': '/var/mail/cltbld', 08:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:43 INFO - 'MOZ_NO_REMOTE': '1', 08:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:43 INFO - 'NO_EM_RESTART': '1', 08:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:43 INFO - 'PWD': '/builds/slave/test', 08:46:43 INFO - 'SHELL': '/bin/bash', 08:46:43 INFO - 'SHLVL': '1', 08:46:43 INFO - 'TERM': 'linux', 08:46:43 INFO - 'TMOUT': '86400', 08:46:43 INFO - 'USER': 'cltbld', 08:46:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:43 INFO - '_': '/tools/buildbot/bin/python'} 08:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:43 INFO - Running setup.py (path:/tmp/pip-EM0NFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:43 INFO - Running setup.py (path:/tmp/pip-7ulUWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:43 INFO - Running setup.py (path:/tmp/pip-68riE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:43 INFO - Running setup.py (path:/tmp/pip-RKJhJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:43 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)) 08:46:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:43 INFO - Running setup.py (path:/tmp/pip-FHyn4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:44 INFO - Running setup.py (path:/tmp/pip-W0tJu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:44 INFO - Running setup.py (path:/tmp/pip-UFmoj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:44 INFO - Running setup.py (path:/tmp/pip-_Zoalj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:44 INFO - Running setup.py (path:/tmp/pip-AzNRtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:44 INFO - Running setup.py (path:/tmp/pip-ZfypB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:44 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)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:44 INFO - Running setup.py (path:/tmp/pip-pAlGbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:44 INFO - Running setup.py (path:/tmp/pip-SvZeFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:44 INFO - Running setup.py (path:/tmp/pip-FJd5Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:44 INFO - Running setup.py (path:/tmp/pip-Xuowbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:44 INFO - Running setup.py (path:/tmp/pip-bVhjdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:44 INFO - Running setup.py (path:/tmp/pip-Gm6mrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:46:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:44 INFO - Running setup.py (path:/tmp/pip-Iyi5ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:44 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)) 08:46:44 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)) 08:46:44 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)) 08:46:44 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)) 08:46:44 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)) 08:46:44 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)) 08:46:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:44 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 08:46:44 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 08:46:44 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 08:46:44 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 08:46:46 INFO - Downloading blessings-1.6.tar.gz 08:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:46 INFO - Installing collected packages: blessings 08:46:46 INFO - Running setup.py install for blessings 08:46:46 INFO - Successfully installed blessings 08:46:46 INFO - Cleaning up... 08:46:46 INFO - Return code: 0 08:46:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:46 INFO - Reading from file tmpfile_stdout 08:46:46 INFO - Current package versions: 08:46:46 INFO - argparse == 1.2.1 08:46:46 INFO - blessings == 1.6 08:46:46 INFO - blobuploader == 1.2.4 08:46:46 INFO - docopt == 0.6.1 08:46:46 INFO - functools32 == 3.2.3-2 08:46:46 INFO - jsonschema == 2.5.1 08:46:46 INFO - manifestparser == 1.1 08:46:46 INFO - mozInstall == 1.12 08:46:46 INFO - mozcrash == 1.0 08:46:46 INFO - mozdebug == 0.1 08:46:46 INFO - mozdevice == 0.51 08:46:46 INFO - mozfile == 1.2 08:46:46 INFO - mozhttpd == 0.7 08:46:46 INFO - mozinfo == 0.9 08:46:46 INFO - mozleak == 0.1 08:46:46 INFO - mozlog == 3.4 08:46:46 INFO - moznetwork == 0.27 08:46:46 INFO - mozprocess == 0.25 08:46:46 INFO - mozprofile == 0.28 08:46:46 INFO - mozrunner == 6.13 08:46:46 INFO - mozscreenshot == 0.1 08:46:46 INFO - mozsystemmonitor == 0.3 08:46:46 INFO - moztest == 0.8 08:46:46 INFO - mozversion == 1.4 08:46:46 INFO - psutil == 3.1.1 08:46:46 INFO - requests == 1.2.3 08:46:46 INFO - wsgiref == 0.1.2 08:46:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:46:46 INFO - Using env: {'DISPLAY': ':0', 08:46:46 INFO - 'HOME': '/home/cltbld', 08:46:46 INFO - 'LANG': 'en_US.UTF-8', 08:46:46 INFO - 'LANGUAGE': 'en_US:en', 08:46:46 INFO - 'LOGNAME': 'cltbld', 08:46:46 INFO - 'MAIL': '/var/mail/cltbld', 08:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:46 INFO - 'MOZ_NO_REMOTE': '1', 08:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:46 INFO - 'NO_EM_RESTART': '1', 08:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:46 INFO - 'PWD': '/builds/slave/test', 08:46:46 INFO - 'SHELL': '/bin/bash', 08:46:46 INFO - 'SHLVL': '1', 08:46:46 INFO - 'TERM': 'linux', 08:46:46 INFO - 'TMOUT': '86400', 08:46:46 INFO - 'USER': 'cltbld', 08:46:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:46 INFO - '_': '/tools/buildbot/bin/python'} 08:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:46:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:46:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:47 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:46:48 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)) 08:46:48 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)) 08:46:48 INFO - Installing collected packages: marionette-driver 08:46:48 INFO - Running setup.py install for marionette-driver 08:46:48 INFO - Successfully installed marionette-driver 08:46:48 INFO - Cleaning up... 08:46:48 INFO - Return code: 0 08:46:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46:48 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')]} 08:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:48 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')]} 08:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:48 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 0x1d9c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2119ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, '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': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', '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 08:46:48 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 08:46:48 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 08:46:48 INFO - Using env: {'DISPLAY': ':0', 08:46:48 INFO - 'HOME': '/home/cltbld', 08:46:48 INFO - 'LANG': 'en_US.UTF-8', 08:46:48 INFO - 'LANGUAGE': 'en_US:en', 08:46:48 INFO - 'LOGNAME': 'cltbld', 08:46:48 INFO - 'MAIL': '/var/mail/cltbld', 08:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:48 INFO - 'MOZ_NO_REMOTE': '1', 08:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:48 INFO - 'NO_EM_RESTART': '1', 08:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:48 INFO - 'PWD': '/builds/slave/test', 08:46:48 INFO - 'SHELL': '/bin/bash', 08:46:48 INFO - 'SHLVL': '1', 08:46:48 INFO - 'TERM': 'linux', 08:46:48 INFO - 'TMOUT': '86400', 08:46:48 INFO - 'USER': 'cltbld', 08:46:48 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:48 INFO - '_': '/tools/buildbot/bin/python'} 08:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:46:48 INFO - Cleaning up... 08:46:48 INFO - Return code: 0 08:46:48 INFO - Running post-action listener: _resource_record_post_action 08:46:48 INFO - Running post-action listener: _start_resource_monitoring 08:46:48 INFO - Starting resource monitoring. 08:46:48 INFO - [mozharness: 2017-05-29 15:46:48.460871Z] Finished create-virtualenv step (success) 08:46:48 INFO - [mozharness: 2017-05-29 15:46:48.461352Z] Running install step. 08:46:48 INFO - Running pre-action listener: _resource_record_pre_action 08:46:48 INFO - Running main action method: install 08:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:48 INFO - Reading from file tmpfile_stdout 08:46:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:48 INFO - Reading from file tmpfile_stdout 08:46:48 INFO - Output received: 08:46:48 INFO - Usage: mozinstall [options] installer 08:46:48 INFO - Options: 08:46:48 INFO - -h, --help show this help message and exit 08:46:48 INFO - -d DEST, --destination=DEST 08:46:48 INFO - Directory to install application into. [default: 08:46:48 INFO - "/builds/slave/test"] 08:46:48 INFO - --app=APP Application being installed. [default: firefox] 08:46:48 INFO - mkdir: /builds/slave/test/build/application 08:46:48 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'] 08:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:47:04 INFO - Reading from file tmpfile_stdout 08:47:04 INFO - Output received: 08:47:04 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:04 INFO - Running post-action listener: _resource_record_post_action 08:47:04 INFO - [mozharness: 2017-05-29 15:47:04.439682Z] Finished install step (success) 08:47:04 INFO - [mozharness: 2017-05-29 15:47:04.439962Z] Running setup-mitmproxy step. 08:47:04 INFO - Running pre-action listener: _resource_record_pre_action 08:47:04 INFO - Running main action method: setup_mitmproxy 08:47:04 INFO - Skipping: mitmproxy is not required 08:47:04 INFO - Running post-action listener: _resource_record_post_action 08:47:04 INFO - [mozharness: 2017-05-29 15:47:04.441090Z] Finished setup-mitmproxy step (success) 08:47:04 INFO - [mozharness: 2017-05-29 15:47:04.441311Z] Running run-tests step. 08:47:04 INFO - Running pre-action listener: _resource_record_pre_action 08:47:04 INFO - Running main action method: run_tests 08:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:04 INFO - Python 2.7.3 08:47:04 INFO - Return code: 0 08:47:04 INFO - grabbing minidump binary from tooltool 08:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:04 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 0x2116e40>, '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 0x2117fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2118440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:04 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 08:47:04 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 08:47:04 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 08:47:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:04 INFO - Return code: 0 08:47:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:04 INFO - ENV: RUST_BACKTRACE is now 1 08:47:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 08:47:04 INFO - Using env: {'DISPLAY': ':0', 08:47:04 INFO - 'HOME': '/home/cltbld', 08:47:04 INFO - 'LANG': 'en_US.UTF-8', 08:47:04 INFO - 'LANGUAGE': 'en_US:en', 08:47:04 INFO - 'LOGNAME': 'cltbld', 08:47:04 INFO - 'MAIL': '/var/mail/cltbld', 08:47:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:04 INFO - 'MOZ_NO_REMOTE': '1', 08:47:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:04 INFO - 'NO_EM_RESTART': '1', 08:47:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:04 INFO - 'PWD': '/builds/slave/test', 08:47:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:04 INFO - 'RUST_BACKTRACE': '1', 08:47:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:47:04 INFO - 'SHELL': '/bin/bash', 08:47:04 INFO - 'SHLVL': '1', 08:47:04 INFO - 'TERM': 'linux', 08:47:04 INFO - 'TMOUT': '86400', 08:47:04 INFO - 'USER': 'cltbld', 08:47:04 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782', 08:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:04 INFO - '_': '/tools/buildbot/bin/python'} 08:47:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:47:04 INFO - mozversion application_buildid: 20170529151805 08:47:04 INFO - mozversion application_changeset: 34ac1a5d6576d6775491c8a882710a1520551da6 08:47:04 INFO - mozversion application_display_name: Nightly 08:47:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:04 INFO - mozversion application_name: Firefox 08:47:04 INFO - mozversion application_remotingname: firefox 08:47:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:04 INFO - mozversion application_vendor: Mozilla 08:47:04 INFO - mozversion application_version: 55.0a1 08:47:04 INFO - mozversion platform_buildid: 20170529151805 08:47:04 INFO - mozversion platform_changeset: 34ac1a5d6576d6775491c8a882710a1520551da6 08:47:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:04 INFO - mozversion platform_version: 55.0a1 08:47:04 INFO - using testdate: 1496072824 08:47:04 INFO - actual date: 1496072824 08:47:04 INFO - starting webserver on 'localhost:53328' 08:47:04 INFO - SUITE-START | Running 2 tests 08:47:04 INFO - TEST-START | dromaeo_css 08:47:04 INFO - operating with platform_type : linux_ 08:47:04 INFO - Initialising browser for dromaeo_css test... 08:47:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53328/getInfo.html -profile /tmp/tmpNr3oXp/profile 08:47:04 INFO - TEST-INFO | started process 12792 (/builds/slave/test/build/application/firefox/firefox http://localhost:53328/getInfo.html) 08:47:40 INFO - TEST-INFO | 12792: killed by SIGTERM 08:47:40 INFO - Browser initialized. 08:47:40 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:40 INFO - TEST-INFO | started process 12990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNr3oXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:52 INFO - PID 12990 | RSS: Main: 181940224 08:47:52 INFO - PID 12990 | 08:50:58 INFO - PID 12990 | Cycle 1(1): loaded http://localhost:53328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53328/tests/dromaeo/cssquery-ext.html) 08:50:59 INFO - PID 12990 | RSS: Main: 177233920 08:50:59 INFO - PID 12990 | 08:54:01 INFO - PID 12990 | Cycle 1(1): loaded http://localhost:53328/tests/dromaeo/cssquery-ext.html (next: http://localhost:53328/tests/dromaeo/cssquery-jquery.html) 08:54:02 INFO - PID 12990 | RSS: Main: 183484416 08:54:02 INFO - PID 12990 | 08:57:04 INFO - PID 12990 | Cycle 1(1): loaded http://localhost:53328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53328/tests/dromaeo/cssquery-mootools.html) 08:57:04 INFO - PID 12990 | RSS: Main: 182026240 08:57:04 INFO - PID 12990 | 09:00:06 INFO - PID 12990 | Cycle 1(1): loaded http://localhost:53328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53328/tests/dromaeo/cssquery-prototype.html) 09:00:07 INFO - PID 12990 | RSS: Main: 184111104 09:00:07 INFO - PID 12990 | 09:03:09 INFO - PID 12990 | Cycle 1(1): loaded http://localhost:53328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53328/tests/dromaeo/cssquery-yui.html) 09:03:10 INFO - PID 12990 | RSS: Main: 183316480 09:03:10 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | Cycle 1(1): loaded http://localhost:53328/tests/dromaeo/cssquery-yui.html (next: http://localhost:53328/tests/dromaeo/cssquery-dojo.html) 09:06:12 INFO - PID 12990 | RSS: Main: 182665216 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | __start_tp_report 09:06:12 INFO - PID 12990 | _x_x_mozilla_page_load 09:06:12 INFO - PID 12990 | _x_x_mozilla_page_load_details 09:06:12 INFO - PID 12990 | |i|pagename|runs| 09:06:12 INFO - PID 12990 | |0;dojo.html;2703.702592714801;2747.95878061829;2759.5998580205883;2771.861406929653;2792.036747322173;5098.923516147261;5212.452692467288;5217.817376391827;5262.789488420468;5296.2320463532815;5217.243499692552;5253.238280449333;5270.183121616146;5336.546393556552;5365.168398898177;4719.9292010619865;4733.053389322149;4754.786034628432;4763.976180119103;4820.638452116088;4734.360861283734;4741.075490279397;4829.299751536025;4831.251156070814;4877.682950608217;4648.535146485358;4681.368015317923;4754.215554433515;4760.143174228638;4816.4461086974925;4717.292406139072;4752.310914917352;4753.04939012199;4775.450823155347;4776.402949631296;4708.835190768341;4732.952670473285;4734.479207287196;4737.147313483571;4761.2382018876815;5225.947740522584;5271.736413179326;5277.076511610453;5286.682799032071;5317.680939143664;5575.442455754433;5663.631863928831;5667.064934285838;5743.109817978178;5752.424757524256;5763.654180749127;5765.596408251424;5768.97115514424;5776.191333213354;5812.564057695689;5316.308879845596;5317.73411329432;5328.413874473805;5333.146696528537;5371.435999220025;5710.600257981901;5710.857228569319;5802.883942321215;5870.765169393262;5876.026885735623;5597.524210442077;5612.691301978431;5626.85932851682;5637.859053523613;5655.3779084300695;5682.687452190169;5704.201411802351;5706.058500347479;5712.0860662293835;5723.456271654186;5536.695481748542;5614.410486898899;5643.209950606918;5663.32040155184;5663.603547751618;5610.607257492018;5701.543876489954;5740.54075673945;5745.195672605755;5750.913736293959;4740.7392593407;4741.928871066937;4758.405199350082;4759.524047595282;4783.4499032611;4102.3026085565525;4105.261053010487;4110.588941105865;4119.732217405859;4157.064660451435;4654.25531914892;4713.6936099153445;4720.669553131316;4751;4835.492273311322;5731.828045158652;5781.797637082682;5792.073268277056;5808.419158084158;5810.128480727924;4817.879553011133;4818;4830.782614782343;4832.540908613676;4862.8784280392565;4934.432540257916;5027.245913112989;5031.773570189277;5041.546260836469;5060.873478163076;5218.55642270396;5294.549963253013;5325.840224793263;5365.38298095724;5401.1088170453;5616.887662246814;5665.348484924287;5704.144378343116;5773.826785196451;5810.389909059488;5351.357837059578;5361.410244873139;5380.650257733391;5398.676079435247;5404.32445944257;5551.639143455824;5648.774049037993;5655.7172141393585;5661.631993920382;5672.943270567242;5601.831945041656;5681.17622944679;5688.146777983336;5781.94218057814;5797;5482.369527504388;5572.804951826666;5590.692511911884;5591.776328946959;5610.074337734228;5450.618456707993;5477.67133971963;5486.533644640251;5501.119820828648;5501.284832971688;5359.678419294854;5364.946350536601;5410.918836217538;5417.160340147283;5459.181122831607;5418.4852439019805;5486.067368547277;5491.066518691752;5496.587755918402;5627.493525582717;5439.700816455133;5470.507654311131;5475.835724928259;5505;5507.944920550904 09:06:12 INFO - PID 12990 | |1;ext.html;664.9168853893264;727.2073439950454;757.821911850715;1213.4418167642884;1244.0731654917088;35152.47271290929;36208.27583448329;36242.27515449689;36242.550297988084;36387.81806090966;34335.656643433555;34712.47931281033;34785.30429391411;34799.82600086996;34832.651673483255;6445.387688169628;6683.498737594676;6811.182658081012;6811.863762724743;6842.555233909805;6692.23039350476;6749.325067493236;6754.628495432749;6772.72909083636;6781.525293229476;6750.93249067508;6788.2193547742145;6798.932010679904;6800.455963522906;6818.9659051704675;6725.932740672604;6772.72909083641;6789.18529776425;6796.6941487632685;6800.081988931505;6733.797986060426;6733.9326606734285;6792.864142717168;6797.2523022467485;6802.761903333359;32209.677903221138;32279.193020174447;32296.19259518507;32313.676863231536;32352;2983.298924752703;2986.7610591152657;3004.053723077224;3007.9548806767916;3018.4868572342534;24420.63369049466;24425.145119920897;24497.63253551198;24521.50956980868;24552.631710524358;3025.3495498467714;3049.4663433898977;3060.02079334613;3068.8772449102007;3079.7844150909445;143286;143769;148047;151538.9999999989;152054;39568.60431395649;39614.405783913266;39712;39729;39739.80130099331;40250;40587.391189132184;40607.39088913669;43925.56074439279;43946;11295.49170287339;11360.48877800501;11388.487518061542;11491.77016459666;11496.022838058692;8723.214910658071;8753.868691969625;8764.21122099014;8830.514321712239;8840.204381605687;12729.172603780724;12935.417906194056;12938.741225175632;12946;13046;5313.149896016619;5322.2548843161985;5328.946710532845;5473.17902314656;5490.752916118784;853.1681610429781;901.0358915959991;904.380499357942;907.4237858959608;929.5816882402946;20701.68947465789;21288.574228515652;21482.78517214839;21588.244411445525;21839.344819655435;964.8600952861796;976.2043934193609;989.2086330935223;993.6770549571419;1005.5475036233724;11016.889831101747;11528.59649912249;14137.363818628186;14652.413903443956;14847.109173449628;176621;178352;179070;180184;180351;44089;44160.77919610382;44255.77872110619;44397.89005274829;44551.331730024074;1174.9471273792528;1201.789686804823;1219.7255617485994;1230.4278510492663;1232.4022848918266;24172.39569010789;24644.753552464244;25436;25555.744442555337;25852.22443326703;30751.53872691956;31017.534736978512;31241.37517249688;31291;31337.373252534366;160526;160772;160911.1954440267;161108;161128;28703.282417939718;28777.136685899455;28879.5668064975;29655.703442965296;30902.381952361276;37319.81340093282;37495.2500949974;37564.62435375611;37581;37584.43623345597;26952.595711064743;27940.860295699204;28027.43945121127;28864;29261.85369073141;27365;27843.303917402227;28378.57432138478;28677.13968580946;29101;31191.532127017657;31356.216094597818;31394.372112558078;31431.52852707257;31516.684833152292;26474.867625661747;26780.330491737863;27082.72917270802;27247.72752272452;27980.160595182177;21528;22288;22539.5492090154;22579;22637.320880373616 09:06:12 INFO - PID 12990 | |2;jquery.html;411.804392913366;414.8589479576945;424.8067129456098;432.49398204101203;441.8343121329501;11494.540218391254;13419;17368.565785855346;17969.101544922767;18118.184681689338;14007.719845603082;17900.28398864044;18061.548461288476;18120.285341504994;18409.17158727857;5390.946090539093;5631.7747290108555;5660.29246344207;5684.914726279109;5693.032184528619;5334.679919204841;5441.483059109379;5446.1558458439;5483.067878460672;5490.094134467828;5376.489233522829;5389.892202155955;5392.622516423852;5395.81114660987;5403.756830942597;5366.785328586851;5373.946260537384;5417.295751552293;5541.639793413416;5610.523105535994;4995.300657907896;5003.649744517885;5026.170681837492;5034.949650503485;5038.143515602356;21900.342989710334;22025.779742202532;22544.210952616744;22619.208327708617;22692;1587.5554844643402;1642.0558179046977;1655.3626853661306;1663.0271291294607;1663.609051872809;13722.519711810039;13898;14035.929820350935;14267.286635668175;14302.92848535761;2001.599680063993;2048.98975505123;2055.1162999910034;2091.243355581319;2120.756113047004;87514.5624271881;88172.11827881703;90068;90301;92161.53919230428;10817.891821081688;10897.782044359068;10918.617848375428;11079.32147585442;11201.495932683049;15338.463153789564;15355.846441535441;15369.231538423033;15393.153376564173;15487.690246195012;7256.637168141572;7355.668994895243;7395.926040739631;7488.812779680552;7502.737404190827;6577.539572229898;6651.201855777338;6795.116634837439;6821;6842.623655698984;6793.830154246085;6883.931160688429;6958.547694399847;6975.9302406975285;7015.228324884259;2062.958740825175;2063.9484012899497;2074.284371891695;2092.5187206942182;2211.734591848988;833.8374017066614;858.3819649852096;861;863.9481631102154;889.5818965086399;16509.422170224225;16711.582210444594;16968.15159242033;17126.314947402214;17375;858.9484630922165;868.3443999780126;876.2770714160843;885.2652298592153;889.7908991387019;9215.53922303882;9258.213051890665;9474.884139997781;9501.857472137923;9562.378445401027;351594;354212;356663;360489;363319;71125.2887471129;72027.63986180036;73702.26297737061;77355.61322193466;79741;1040.552562398176;1043.5564884923876;1072.0030371754187;1098.6484325016079;1098.906592939593;16797.748033779746;18184;18954.715679265097;19145.712814308074;19214.80785192186;39624.80187599044;40274.59725402826;40409;40507.1898562033;41065.178696425304;51013;52096;52432.737836310574;52840.73579632077;53255.46744532505;8269.62786674589;8314.334853211849;8582.957085214533;8609.139086091342;8763.91236087631;12590.874091258971;12881.549145779853;13145;13196.736065278448;13217.206967581977;11349;11350.375729334966;11373;11604.245724027911;11653.126015548698;10442.947785261025;10522.526486308288;10604.787904241717;10760.784784304113;10770.192235582519;11269.098472122374;11333.356663283943;11336.149788765711;11378.43107844621;11781.941090294493;8118.147594502729;8342.62235262947;8356.832863342577;8525.317974562144;8668.393212475066;11117.22179447431;11126.55493780272;11202.15983801202;11290.322580645188;11520.078393728649 09:06:12 INFO - PID 12990 | |3;mootools.html;1286.922784632922;1357.8913686905048;1366.8974826887986;1368.787837885128;1371.8353797544296;10489.895101048987;10902.182336324768;10994;11006.614768483105;11401.828972565398;11014.724631884186;11165.38590377529;11171.83242251365;11201.327920324786;11222.66332010041;2216.279709094543;2244.6969659095976;2246.5731511012937;2250.4261413339577;2250.583642026222;2120.54408302215;2148.1729534129317;2149.924752633658;2158.5467051919036;2162.0595041157067;2115.7038014677955;2154.9353519394444;2159.3953692965993;2161.664941934003;2165.436986383536;2130.4886827161527;2132.0832042221837;2133.3919832847564;2137.5938571671486;2143.8928053597256;2073.3676228750223;2131.914723411062;2220.8334374921783;2221.7444993825757;2223.177424353;10755;10857.294275872122;10860.782784344348;10865.348079115278;10874;5658.632188907749;5855.355910849803;5855.443732845373;5898.528117750569;5903.0555111182;3349.949750753741;3512.209752805624;3558.2883423315184;3561.5370001899846;3567.4113771227717;1020.8519764634086;1041.0474415909434;1068.2522234435849;1076.8923107689247;1097.983530247047;16047.277872495766;16158.838411615969;16203.91898040514;16244.187790610422;16262.83737162625;4815;4840.724859316116;4931.4821943696115;4985.177445721415;5008.273800298936;11756.470958806874;11796.94101529487;11802.881971180179;11813.291202527877;11834.05327573792;5568.331800184003;5622.269105016404;5641.26663533738;5678.744456499468;5695.202671625976;5134.820281290212;5212.713300768418;5214.869628259324;5251.658642188246;5262.2632831403635;3928.8035598220545;3992.680585553149;4000.2799496090984;4048.69634777387;4170.958290417057;1132.3375825142218;1133.5239199536215;1138.9031932285682;1160.640201537526;1161.7734541764444;677.7560078371782;701.1095908196562;702.5293053653962;715.7351779841388;718.5365439291733;5525.309336332958;5583.106702927512;5609.718314785896;5632.929743348751;5729;550.3231025838242;571.977120915167;573.9799107031234;851.3614788908319;875.0418291970283;3762.9275656437785;3934.6065393460426;3951.9377691346;3957.6240257175523;4010.1177740896956;13562.389692463863;13670.453181872812;14199.503017394341;14294.070885392417;14369.497067602584;13891.513797017056;13906.721865562633;14087.22520261375;14160.575182744535;14204.928975355057;7477.364424024019;7681.7695469136015;7765.650545725569;7771.805704857311;7783.727569535039;6318.747250109944;6386.457151142019;6530.151080359523;6569.441597464269;6634.038064480526;12728.1726687765;13034.869651303365;13064.412101455648;13077.476900923857;13118.475260989835;12959.740805184032;13159.210447373189;13311.46754129824;13356.532521361705;13468.461261549428;8774.956125219333;8913.732588022369;9201.217896478875;9232.122948319899;9298.163165315154;10511.737206569896;10630.574777008833;10635.680929572125;10640.52117654692;10667.786644267226;8532.744017679479;8597.441166324168;8815.338849586178;8935.240504556925;8950.641974320954;8455;8545.359098067545;8545.487270763773;8552.401331906707;8653.30773538128;7808.336291415066;7875.173106823701;7898.565578892986;7929;7930.167332430012;5459.908018396416;5463.781448742165;5534.252875861707;5541.944580554143;5706.28671416073;5395.703236321883;5396.7571459283645;5474.644148130359;5551.279103477935;5663.093904975184 09:06:12 INFO - PID 12990 | |4;prototype.html;378.5344026846978;394.62510614915834;399.4188455796816;400.6814582406986;401.2596758979681;5369.892602147955;5517.972410137949;5524.751386187621;5526.58550608704;5542.140968149938;5275.736213189344;5368.409474957752;5380.461953804617;5384.5692344612435;5388.515033646981;4119.361498967664;4121.855735049274;4126.277901367263;4132.855350062749;4141.494395890488;3974.642282194602;4106.835726570934;4136.172765446908;4142.316517774579;4146.253674338618;4093.9385909211387;4095.5904409558952;4111.321631930728;4112.074783173792;4116.608922152391;4084.7344922580232;4085.305498065351;4093.9795301023305;4094.7338423002557;4110.445089912853;3459.8789042383396;3624.9456258156147;3638.6543278388776;3643.344198044351;3652.2330310634798;5266.683998960037;5293.39126000511;5303.36359636846;5309.283246761676;5316.229146773735;4785.21044027735;4821.638377121695;4825.7587120644175;4832.589229915461;4836.443808961944;5520;5605.20633397313;5634.577406694514;5706.231068368819;5717.342505611867;4061.675065994743;4070.3283958147167;4071.246819338432;4077.612626800449;4098.4876890388705;5798.652080875161;6002.909956350614;6033.276006879202;6045.3652366501765;6117.143599896018;4084.8366065357645;4100;4100.0569868930315;4110.712250142461;4125.793710314472;4157.752674197729;4161.417401563784;4164.292070348048;4167.666586673059;4174.227767862894;4674.6026587740425;4738.455077666113;4759.524047595212;4768.880777980509;4787.904241915142;5733.856653583611;5750.539956803445;5755.884882302331;5758.165066065397;5772.913406298909;1415.7027024325007;1419.936102875373;1422.49501426994;1426.6362077670128;1427.293489722594;923.0492592629603;984.6504490905769;987.9110880020833;989.0702739424918;993.1260490768078;4899.314096026559;4911.631627627942;4951.935333903228;4957.256411538298;4972.229304457815;5906;5909.113632955091;5923.466887980103;5926.2295901532525;5929.436703513159;4690.882727931761;4858.854234372974;4888.608911287089;4898.975505122452;4910.435299940553;3101.457244982119;3137.7803553751473;3139.937201255962;3145;3146.1819926818735;5469.671819690831;5518.475744804237;5551.000819852385;5554.250176226238;5554.666719996813;5994.310654274727;6021.2473440819895;6048.364921683248;6050.2437195350585;6102.389761023862;5522.66863988154;5525.944740552623;5534.142207957773;5538.47384498472;5544.7782088716;5666.376698563073;5871.506453660066;5932.733027013881;5944.851378715567;5972.8805423892145;5876.735546900314;5880.442007726652;5894.705264736832;5896.528277737685;5911.290645122613;5378.704171270618;5512.39363669988;5556.305461817273;5556.694381809039;5601.039636127322;4157.688173387069;4157.729747566398;4179.414881916595;4184.267753143127;4190.916181676411;5844.824655260349;6007.146605362593;6016.338202797601;6025.367336429612;6031.306399763907;5755.453231942959;5759.280089988752;5777.971110144423;5786.161006654096;5789.45000224978;5735.71321433935;5775.9133612995;5777.480026797609;5778.595498315078;5788.131780232999;5458.836234912959;5662.348829884451;5694.259746232963;5706.657600543981;5724.713764311685;5762.250907382014;5797.869415463944;5807.564432667482;5809.796657116981;5818.534517238526;5511.834644960658;5591.608587398843;5641.971790141023;5650.180723795109;5658.490735833795 09:06:12 INFO - PID 12990 | |5;yui.html;741.5291290030835;751.9887201691972;757.7688804914501;763.8281386687993;776.9339606133476;13488;14425.783613245796;14459.349329280181;15607.375704971815;16983.57541061474;16708.916455417737;16778;16948.406805761802;16970.915145424256;16998.235079421425;845.8266055458616;877.1929824561403;897.4121950122648;902.0933961368848;903.336048004716;890.1187824054172;891.6477991193475;892.6474042753109;895.1630225738955;896.8027034052498;938.6104766521885;939.8684184214181;940.196132306878;942.4439580647417;944.7496413450441;941.5998200764716;942.1002942190192;942.7831598732262;943.1652987106426;948.1135138645388;683.0607914118087;689.1454596300551;691.3432239372617;692.560224257595;696.022088965005;14909.850901490954;15285.388584456608;15402.306896189699;15419.460318888898;15436.691266174726;16386.918065409598;16694.58263543421;16698.165091745363;16791.66416671672;16815.0751708656;12548.435320410512;13057.281849498273;13089.934550327283;13241.933790330986;13288.933555332162;3030.212144842335;3033.0294305822144;3044.756419486436;3046.908592742221;3063.0657649416917;83160;86064.56967715184;86761.56619216864;87832.99999999936;88375.11624883734;12031.939840300918;12292.323922184365;12481.126321157431;12528;12623.305718185404;20240.696389554167;20382.592348152953;20451;20469.692954605693;20531.178752850017;5915.733791979371;6081.118237855575;6081.179040829431;6102.542309326818;6107.358727333566;2978.508546089914;3038.8176709397067;3042.4827779277575;3048.481758101128;3051.7182783231096;3874.1670540833857;3953.3081710700512;3956.802159891994;3971.483707118114;3980.522337319482;707.8230442389403;716.3266529462289;717.2003216413661;718.3714250031222;719.0329007484925;526.3000209721062;537.5511447940935;596.9731362088717;619.8729260501586;626.1828314050208;9929.801403972024;10026.248031397528;10423.478826058667;11013.669589912315;11304.15218858589;616.6669998201011;617.4813156948095;620.2835724737935;625.1123404765244;630.2153818496001;4597.770111494478;4712.740799256074;4792.544708252711;4915.115279249698;4918.877028074256;80936;82155;82341.58829205936;83883.58058209669;84468.57765711132;76016;76449.23550764532;77026;77927;78598.6070069646;64734.676326618064;67482;67915.3208467909;67960.66019669968;68993.31006689869;10262.692119236435;10461.633842815465;11243.212975091992;11249.775004500028;11424.714382140513;27385.45229095447;27551.31121721893;27602.723972760818;29089.7091029087;29588.852055740444;50286;51253;51254.231186531484;51702;53584.73207634093;14911.925440372728;14916.701665966837;15441.0735355879;15448.768268475756;15538.611534711723;16225.350985960902;16746.246418910934;16864.409745658842;16880.915595421946;17045.31818727237;14292.428302868184;14831.703365932837;15450.613734656723;15702.685946281239;15743.842561574696;15121.546353609408;15465.536033919001;15806.130662813655;15837.841621584097;16106.27521761547;14553.708925821637;14956.850431495546;15430.151341676315;15462.690746185239;15625.765613516034;11264.605738799102;11303.491342889754;11390.829137562778;11508.654740357802;11945.283283003047;11640.94179529097;11938.641840744443;12121.575744848888;12162.998761832361;12323.50705971751 09:06:12 INFO - PID 12990 | __end_tp_report 09:06:12 INFO - PID 12990 | __start_cc_report 09:06:12 INFO - PID 12990 | _x_x_mozilla_cycle_collect,380 09:06:12 INFO - PID 12990 | __end_cc_report 09:06:12 INFO - PID 12990 | __startTimestamp1496073972444__endTimestamp 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | ------- Summary: start ------- 09:06:12 INFO - PID 12990 | Number of tests: 6 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | [#0] dojo.html Cycles:165 Average:5212.74 Median:5371.44 stddev:608.21 (11.3%) stddev-sans-first:577.35 09:06:12 INFO - PID 12990 | Values: 2703.7 2748.0 2759.6 2771.9 2792.0 5098.9 5212.5 5217.8 5262.8 5296.2 5217.2 5253.2 5270.2 5336.5 5365.2 4719.9 4733.1 4754.8 4764.0 4820.6 4734.4 4741.1 4829.3 4831.3 4877.7 4648.5 4681.4 4754.2 4760.1 4816.4 4717.3 4752.3 4753.0 4775.5 4776.4 4708.8 4733.0 4734.5 4737.1 4761.2 5225.9 5271.7 5277.1 5286.7 5317.7 5575.4 5663.6 5667.1 5743.1 5752.4 5763.7 5765.6 5769.0 5776.2 5812.6 5316.3 5317.7 5328.4 5333.1 5371.4 5710.6 5710.9 5802.9 5870.8 5876.0 5597.5 5612.7 5626.9 5637.9 5655.4 5682.7 5704.2 5706.1 5712.1 5723.5 5536.7 5614.4 5643.2 5663.3 5663.6 5610.6 5701.5 5740.5 5745.2 5750.9 4740.7 4741.9 4758.4 4759.5 4783.4 4102.3 4105.3 4110.6 4119.7 4157.1 4654.3 4713.7 4720.7 4751.0 4835.5 5731.8 5781.8 5792.1 5808.4 5810.1 4817.9 4818.0 4830.8 4832.5 4862.9 4934.4 5027.2 5031.8 5041.5 5060.9 5218.6 5294.5 5325.8 5365.4 5401.1 5616.9 5665.3 5704.1 5773.8 5810.4 5351.4 5361.4 5380.7 5398.7 5404.3 5551.6 5648.8 5655.7 5661.6 5672.9 5601.8 5681.2 5688.1 5781.9 5797.0 5482.4 5572.8 5590.7 5591.8 5610.1 5450.6 5477.7 5486.5 5501.1 5501.3 5359.7 5364.9 5410.9 5417.2 5459.2 5418.5 5486.1 5491.1 5496.6 5627.5 5439.7 5470.5 5475.8 5505.0 5507.9 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | [#1] ext.html Cycles:180 Average:31064.43 Median:31216.45 stddev:42086.19 (134.8%) stddev-sans-first:42142.34 09:06:12 INFO - PID 12990 | Values: 664.9 727.2 757.8 1213.4 1244.1 35152.5 36208.3 36242.3 36242.6 36387.8 34335.7 34712.5 34785.3 34799.8 34832.7 6445.4 6683.5 6811.2 6811.9 6842.6 6692.2 6749.3 6754.6 6772.7 6781.5 6750.9 6788.2 6798.9 6800.5 6819.0 6725.9 6772.7 6789.2 6796.7 6800.1 6733.8 6733.9 6792.9 6797.3 6802.8 32209.7 32279.2 32296.2 32313.7 32352.0 2983.3 2986.8 3004.1 3008.0 3018.5 24420.6 24425.1 24497.6 24521.5 24552.6 3025.3 3049.5 3060.0 3068.9 3079.8 143286.0 143769.0 148047.0 151539.0 152054.0 39568.6 39614.4 39712.0 39729.0 39739.8 40250.0 40587.4 40607.4 43925.6 43946.0 11295.5 11360.5 11388.5 11491.8 11496.0 8723.2 8753.9 8764.2 8830.5 8840.2 12729.2 12935.4 12938.7 12946.0 13046.0 5313.1 5322.3 5328.9 5473.2 5490.8 853.2 901.0 904.4 907.4 929.6 20701.7 21288.6 21482.8 21588.2 21839.3 964.9 976.2 989.2 993.7 1005.5 11016.9 11528.6 14137.4 14652.4 14847.1 176621.0 178352.0 179070.0 180184.0 180351.0 44089.0 44160.8 44255.8 44397.9 44551.3 1174.9 1201.8 1219.7 1230.4 1232.4 24172.4 24644.8 25436.0 25555.7 25852.2 30751.5 31017.5 31241.4 31291.0 31337.4 160526.0 160772.0 160911.2 161108.0 161128.0 28703.3 28777.1 28879.6 29655.7 30902.4 37319.8 37495.3 37564.6 37581.0 37584.4 26952.6 27940.9 28027.4 28864.0 29261.9 27365.0 27843.3 28378.6 28677.1 29101.0 31191.5 31356.2 31394.4 31431.5 31516.7 26474.9 26780.3 27082.7 27247.7 27980.2 21528.0 22288.0 22539.5 22579.0 22637.3 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | [#2] jquery.html Cycles:180 Average:24628.93 Median:39949.70 stddev:59624.57 (149.2%) stddev-sans-first:59764.11 09:06:12 INFO - PID 12990 | Values: 411.8 414.9 424.8 432.5 441.8 11494.5 13419.0 17368.6 17969.1 18118.2 14007.7 17900.3 18061.5 18120.3 18409.2 5390.9 5631.8 5660.3 5684.9 5693.0 5334.7 5441.5 5446.2 5483.1 5490.1 5376.5 5389.9 5392.6 5395.8 5403.8 5366.8 5373.9 5417.3 5541.6 5610.5 4995.3 5003.6 5026.2 5034.9 5038.1 21900.3 22025.8 22544.2 22619.2 22692.0 1587.6 1642.1 1655.4 1663.0 1663.6 13722.5 13898.0 14035.9 14267.3 14302.9 2001.6 2049.0 2055.1 2091.2 2120.8 87514.6 88172.1 90068.0 90301.0 92161.5 10817.9 10897.8 10918.6 11079.3 11201.5 15338.5 15355.8 15369.2 15393.2 15487.7 7256.6 7355.7 7395.9 7488.8 7502.7 6577.5 6651.2 6795.1 6821.0 6842.6 6793.8 6883.9 6958.5 6975.9 7015.2 2063.0 2063.9 2074.3 2092.5 2211.7 833.8 858.4 861.0 863.9 889.6 16509.4 16711.6 16968.2 17126.3 17375.0 858.9 868.3 876.3 885.3 889.8 9215.5 9258.2 9474.9 9501.9 9562.4 351594.0 354212.0 356663.0 360489.0 363319.0 71125.3 72027.6 73702.3 77355.6 79741.0 1040.6 1043.6 1072.0 1098.6 1098.9 16797.7 18184.0 18954.7 19145.7 19214.8 39624.8 40274.6 40409.0 40507.2 41065.2 51013.0 52096.0 52432.7 52840.7 53255.5 8269.6 8314.3 8583.0 8609.1 8763.9 12590.9 12881.5 13145.0 13196.7 13217.2 11349.0 11350.4 11373.0 11604.2 11653.1 10442.9 10522.5 10604.8 10760.8 10770.2 11269.1 11333.4 11336.1 11378.4 11781.9 8118.1 8342.6 8356.8 8525.3 8668.4 11117.2 11126.6 11202.2 11290.3 11520.1 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | [#3] mootools.html Cycles:180 Average:6663.14 Median:3431.08 stddev:4406.79 (128.4%) stddev-sans-first:4400.64 09:06:12 INFO - PID 12990 | Values: 1286.9 1357.9 1366.9 1368.8 1371.8 10489.9 10902.2 10994.0 11006.6 11401.8 11014.7 11165.4 11171.8 11201.3 11222.7 2216.3 2244.7 2246.6 2250.4 2250.6 2120.5 2148.2 2149.9 2158.5 2162.1 2115.7 2154.9 2159.4 2161.7 2165.4 2130.5 2132.1 2133.4 2137.6 2143.9 2073.4 2131.9 2220.8 2221.7 2223.2 10755.0 10857.3 10860.8 10865.3 10874.0 5658.6 5855.4 5855.4 5898.5 5903.1 3349.9 3512.2 3558.3 3561.5 3567.4 1020.9 1041.0 1068.3 1076.9 1098.0 16047.3 16158.8 16203.9 16244.2 16262.8 4815.0 4840.7 4931.5 4985.2 5008.3 11756.5 11796.9 11802.9 11813.3 11834.1 5568.3 5622.3 5641.3 5678.7 5695.2 5134.8 5212.7 5214.9 5251.7 5262.3 3928.8 3992.7 4000.3 4048.7 4171.0 1132.3 1133.5 1138.9 1160.6 1161.8 677.8 701.1 702.5 715.7 718.5 5525.3 5583.1 5609.7 5632.9 5729.0 550.3 572.0 574.0 851.4 875.0 3762.9 3934.6 3951.9 3957.6 4010.1 13562.4 13670.5 14199.5 14294.1 14369.5 13891.5 13906.7 14087.2 14160.6 14204.9 7477.4 7681.8 7765.7 7771.8 7783.7 6318.7 6386.5 6530.2 6569.4 6634.0 12728.2 13034.9 13064.4 13077.5 13118.5 12959.7 13159.2 13311.5 13356.5 13468.5 8775.0 8913.7 9201.2 9232.1 9298.2 10511.7 10630.6 10635.7 10640.5 10667.8 8532.7 8597.4 8815.3 8935.2 8950.6 8455.0 8545.4 8545.5 8552.4 8653.3 7808.3 7875.2 7898.6 7929.0 7930.2 5459.9 5463.8 5534.3 5541.9 5706.3 5395.7 5396.8 5474.6 5551.3 5663.1 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | [#4] prototype.html Cycles:180 Average:4730.07 Median:5386.54 stddev:1396.42 (25.9%) stddev-sans-first:1361.60 09:06:12 INFO - PID 12990 | Values: 378.5 394.6 399.4 400.7 401.3 5369.9 5518.0 5524.8 5526.6 5542.1 5275.7 5368.4 5380.5 5384.6 5388.5 4119.4 4121.9 4126.3 4132.9 4141.5 3974.6 4106.8 4136.2 4142.3 4146.3 4093.9 4095.6 4111.3 4112.1 4116.6 4084.7 4085.3 4094.0 4094.7 4110.4 3459.9 3624.9 3638.7 3643.3 3652.2 5266.7 5293.4 5303.4 5309.3 5316.2 4785.2 4821.6 4825.8 4832.6 4836.4 5520.0 5605.2 5634.6 5706.2 5717.3 4061.7 4070.3 4071.2 4077.6 4098.5 5798.7 6002.9 6033.3 6045.4 6117.1 4084.8 4100.0 4100.1 4110.7 4125.8 4157.8 4161.4 4164.3 4167.7 4174.2 4674.6 4738.5 4759.5 4768.9 4787.9 5733.9 5750.5 5755.9 5758.2 5772.9 1415.7 1419.9 1422.5 1426.6 1427.3 923.0 984.7 987.9 989.1 993.1 4899.3 4911.6 4951.9 4957.3 4972.2 5906.0 5909.1 5923.5 5926.2 5929.4 4690.9 4858.9 4888.6 4899.0 4910.4 3101.5 3137.8 3139.9 3145.0 3146.2 5469.7 5518.5 5551.0 5554.3 5554.7 5994.3 6021.2 6048.4 6050.2 6102.4 5522.7 5525.9 5534.1 5538.5 5544.8 5666.4 5871.5 5932.7 5944.9 5972.9 5876.7 5880.4 5894.7 5896.5 5911.3 5378.7 5512.4 5556.3 5556.7 5601.0 4157.7 4157.7 4179.4 4184.3 4190.9 5844.8 6007.1 6016.3 6025.4 6031.3 5755.5 5759.3 5778.0 5786.2 5789.5 5735.7 5775.9 5777.5 5778.6 5788.1 5458.8 5662.3 5694.3 5706.7 5724.7 5762.3 5797.9 5807.6 5809.8 5818.5 5511.8 5591.6 5642.0 5650.2 5658.5 09:06:12 INFO - PID 12990 | 09:06:12 INFO - PID 12990 | [#5] yui.html Cycles:180 Average:18176.05 Median:3047.70 stddev:23634.35 (775.5%) stddev-sans-first:23664.39 09:06:12 INFO - PID 12990 | Values: 741.5 752.0 757.8 763.8 776.9 13488.0 14425.8 14459.3 15607.4 16983.6 16708.9 16778.0 16948.4 16970.9 16998.2 845.8 877.2 897.4 902.1 903.3 890.1 891.6 892.6 895.2 896.8 938.6 939.9 940.2 942.4 944.7 941.6 942.1 942.8 943.2 948.1 683.1 689.1 691.3 692.6 696.0 14909.9 15285.4 15402.3 15419.5 15436.7 16386.9 16694.6 16698.2 16791.7 16815.1 12548.4 13057.3 13089.9 13241.9 13288.9 3030.2 3033.0 3044.8 3046.9 3063.1 83160.0 86064.6 86761.6 87833.0 88375.1 12031.9 12292.3 12481.1 12528.0 12623.3 20240.7 20382.6 20451.0 20469.7 20531.2 5915.7 6081.1 6081.2 6102.5 6107.4 2978.5 3038.8 3042.5 3048.5 3051.7 3874.2 3953.3 3956.8 3971.5 3980.5 707.8 716.3 717.2 718.4 719.0 526.3 537.6 597.0 619.9 626.2 9929.8 10026.2 10423.5 11013.7 11304.2 616.7 617.5 620.3 625.1 630.2 4597.8 4712.7 4792.5 4915.1 4918.9 80936.0 82155.0 82341.6 83883.6 84468.6 76016.0 76449.2 77026.0 77927.0 78598.6 64734.7 67482.0 67915.3 67960.7 68993.3 10262.7 10461.6 11243.2 11249.8 11424.7 27385.5 27551.3 27602.7 29089.7 29588.9 50286.0 51253.0 51254.2 51702.0 53584.7 14911.9 14916.7 15441.1 15448.8 15538.6 16225.4 16746.2 16864.4 16880.9 17045.3 14292.4 14831.7 15450.6 15702.7 15743.8 15121.5 15465.5 15806.1 15837.8 16106.3 14553.7 14956.9 15430.2 15462.7 15625.8 11264.6 11303.5 11390.8 11508.7 11945.3 11640.9 11938.6 12121.6 12163.0 12323.5 09:06:12 INFO - PID 12990 | -------- Summary: end -------- 09:06:12 INFO - PID 12990 | 09:06:13 INFO - TEST-INFO | 12990: exit 0 09:06:13 INFO - TEST-OK | dromaeo_css | took 1148586ms 09:06:13 INFO - TEST-START | kraken 09:06:13 INFO - operating with platform_type : linux_ 09:06:13 INFO - Initialising browser for kraken test... 09:06:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53328/getInfo.html -profile /tmp/tmpK7mq6R/profile 09:06:13 INFO - TEST-INFO | started process 13394 (/builds/slave/test/build/application/firefox/firefox http://localhost:53328/getInfo.html) 09:06:48 INFO - TEST-INFO | 13394: killed by SIGTERM 09:06:48 INFO - Browser initialized. 09:06:48 INFO - Running cycle 1/1 for kraken test... 09:06:48 INFO - TEST-INFO | started process 13595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK7mq6R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:00 INFO - PID 13595 | RSS: Main: 182849536 09:07:00 INFO - PID 13595 | 09:07:03 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53328/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:04 INFO - PID 13595 | RSS: Main: 186507264 09:07:04 INFO - PID 13595 | 09:07:06 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53328/tests/kraken/driver.html?testName=audio-dft) 09:07:07 INFO - PID 13595 | RSS: Main: 185253888 09:07:07 INFO - PID 13595 | 09:07:10 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53328/tests/kraken/driver.html?testName=audio-fft) 09:07:11 INFO - PID 13595 | RSS: Main: 181252096 09:07:11 INFO - PID 13595 | 09:07:13 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53328/tests/kraken/driver.html?testName=audio-oscillator) 09:07:13 INFO - PID 13595 | RSS: Main: 182247424 09:07:13 INFO - PID 13595 | 09:07:16 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:16 INFO - PID 13595 | RSS: Main: 182185984 09:07:16 INFO - PID 13595 | 09:07:19 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53328/tests/kraken/driver.html?testName=imaging-darkroom) 09:07:20 INFO - PID 13595 | RSS: Main: 183476224 09:07:20 INFO - PID 13595 | 09:07:23 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53328/tests/kraken/driver.html?testName=imaging-desaturate) 09:07:24 INFO - PID 13595 | RSS: Main: 182026240 09:07:24 INFO - PID 13595 | 09:07:27 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53328/tests/kraken/driver.html?testName=json-parse-financial) 09:07:28 INFO - PID 13595 | RSS: Main: 182558720 09:07:28 INFO - PID 13595 | 09:07:29 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:30 INFO - PID 13595 | RSS: Main: 183078912 09:07:30 INFO - PID 13595 | 09:07:32 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:32 INFO - PID 13595 | RSS: Main: 182550528 09:07:32 INFO - PID 13595 | 09:07:35 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:35 INFO - PID 13595 | RSS: Main: 182726656 09:07:35 INFO - PID 13595 | 09:07:38 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:39 INFO - PID 13595 | RSS: Main: 182562816 09:07:39 INFO - PID 13595 | 09:07:42 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:43 INFO - PID 13595 | RSS: Main: 182898688 09:07:43 INFO - PID 13595 | 09:07:44 INFO - PID 13595 | Cycle 1(1): loaded http://localhost:53328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53328/tests/kraken/driver.html?testName=ai-astar) 09:07:45 INFO - PID 13595 | RSS: Main: 184266752 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | __start_tp_report 09:07:45 INFO - PID 13595 | _x_x_mozilla_page_load 09:07:45 INFO - PID 13595 | _x_x_mozilla_page_load_details 09:07:45 INFO - PID 13595 | |i|pagename|runs| 09:07:45 INFO - PID 13595 | |0;ai-astar;102;110;111;109;110;111;111;112;112;111 09:07:45 INFO - PID 13595 | |1;audio-beat-detection;155;131;123;168;122;124;124;122;151;127 09:07:45 INFO - PID 13595 | |2;audio-dft;167;164;166;167;167;175;165;164;166;165 09:07:45 INFO - PID 13595 | |3;audio-fft;74;74;76;109;78;79;74;75;96;74 09:07:45 INFO - PID 13595 | |4;audio-oscillator;83;86;109;83;83;82;102;83;83;108 09:07:45 INFO - PID 13595 | |5;imaging-gaussian-blur;114;114;114;114;114;114;115;114;114;114 09:07:45 INFO - PID 13595 | |6;imaging-darkroom;150;151;150;152;151;151;151;152;151;151 09:07:45 INFO - PID 13595 | |7;imaging-desaturate;94;95;95;96;96;96;94;95;96;94 09:07:45 INFO - PID 13595 | |8;json-parse-financial;55;54;56;59;65;56;57;56;56;56 09:07:45 INFO - PID 13595 | |9;json-stringify-tinderbox;56;56;56;56;56;56;56;56;57;56 09:07:45 INFO - PID 13595 | |10;stanford-crypto-aes;88;90;86;87;87;86;89;98;125;96 09:07:45 INFO - PID 13595 | |11;stanford-crypto-ccm;140;133;143;132;146;132;143;135;135;135 09:07:45 INFO - PID 13595 | |12;stanford-crypto-pbkdf2;186;196;199;194;192;187;194;187;200;188 09:07:45 INFO - PID 13595 | |13;stanford-crypto-sha256-iterative;75;76;72;71;74;71;70;74;74;77 09:07:45 INFO - PID 13595 | __end_tp_report 09:07:45 INFO - PID 13595 | __start_cc_report 09:07:45 INFO - PID 13595 | _x_x_mozilla_cycle_collect,1031 09:07:45 INFO - PID 13595 | __end_cc_report 09:07:45 INFO - PID 13595 | __startTimestamp1496074065164__endTimestamp 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | ------- Summary: start ------- 09:07:45 INFO - PID 13595 | Number of tests: 14 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.92 (2.6%) stddev-sans-first:0.97 09:07:45 INFO - PID 13595 | Values: 102.0 110.0 111.0 109.0 110.0 111.0 111.0 112.0 112.0 111.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:129.00 stddev:16.83 (13.0%) stddev-sans-first:16.16 09:07:45 INFO - PID 13595 | Values: 155.0 131.0 123.0 168.0 122.0 124.0 124.0 122.0 151.0 127.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.50 stddev:3.17 (1.9%) stddev-sans-first:3.36 09:07:45 INFO - PID 13595 | Values: 167.0 164.0 166.0 167.0 167.0 175.0 165.0 164.0 166.0 165.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.50 stddev:11.92 (15.8%) stddev-sans-first:12.38 09:07:45 INFO - PID 13595 | Values: 74.0 74.0 76.0 109.0 78.0 79.0 74.0 75.0 96.0 74.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.00 stddev:11.32 (13.6%) stddev-sans-first:11.70 09:07:45 INFO - PID 13595 | Values: 83.0 86.0 109.0 83.0 83.0 82.0 102.0 83.0 83.0 108.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:07:45 INFO - PID 13595 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 09:07:45 INFO - PID 13595 | Values: 150.0 151.0 150.0 152.0 151.0 151.0 151.0 152.0 151.0 151.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.50 stddev:0.88 (0.9%) stddev-sans-first:0.83 09:07:45 INFO - PID 13595 | Values: 94.0 95.0 95.0 96.0 96.0 96.0 94.0 95.0 96.0 94.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.00 stddev:3.09 (5.5%) stddev-sans-first:3.19 09:07:45 INFO - PID 13595 | Values: 55.0 54.0 56.0 59.0 65.0 56.0 57.0 56.0 56.0 56.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 09:07:45 INFO - PID 13595 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:88.50 stddev:11.91 (13.5%) stddev-sans-first:12.49 09:07:45 INFO - PID 13595 | Values: 88.0 90.0 86.0 87.0 87.0 86.0 89.0 98.0 125.0 96.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:137.50 stddev:5.15 (3.7%) stddev-sans-first:5.37 09:07:45 INFO - PID 13595 | Values: 140.0 133.0 143.0 132.0 146.0 132.0 143.0 135.0 135.0 135.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:194.00 stddev:5.14 (2.7%) stddev-sans-first:4.92 09:07:45 INFO - PID 13595 | Values: 186.0 196.0 199.0 194.0 192.0 187.0 194.0 187.0 200.0 188.0 09:07:45 INFO - PID 13595 | 09:07:45 INFO - PID 13595 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:74.00 stddev:2.32 (3.1%) stddev-sans-first:2.39 09:07:45 INFO - PID 13595 | Values: 75.0 76.0 72.0 71.0 74.0 71.0 70.0 74.0 74.0 77.0 09:07:45 INFO - PID 13595 | -------- Summary: end -------- 09:07:45 INFO - PID 13595 | 09:07:46 INFO - TEST-INFO | 13595: exit 0 09:07:46 INFO - TEST-OK | kraken | took 92998ms 09:07:46 INFO - SUITE-END | took 1241s 09:07:46 INFO - Completed test suite (00:20:42) 09:07:46 INFO - javascript benchmark 09:07:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6863.871237041518, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2703.702592714801, 2747.95878061829, 2759.5998580205883, 2771.861406929653, 2792.036747322173, 5098.923516147261, 5212.452692467288, 5217.817376391827, 5262.789488420468, 5296.2320463532815, 5217.243499692552, 5253.238280449333, 5270.183121616146, 5336.546393556552, 5365.168398898177, 4719.9292010619865, 4733.053389322149, 4754.786034628432, 4763.976180119103, 4820.638452116088, 4734.360861283734, 4741.075490279397, 4829.299751536025, 4831.251156070814, 4877.682950608217, 4648.535146485358, 4681.368015317923, 4754.215554433515, 4760.143174228638, 4816.4461086974925, 4717.292406139072, 4752.310914917352, 4753.04939012199, 4775.450823155347, 4776.402949631296, 4708.835190768341, 4732.952670473285, 4734.479207287196, 4737.147313483571, 4761.2382018876815, 5225.947740522584, 5271.736413179326, 5277.076511610453, 5286.682799032071, 5317.680939143664, 5575.442455754433, 5663.631863928831, 5667.064934285838, 5743.109817978178, 5752.424757524256, 5763.654180749127, 5765.596408251424, 5768.97115514424, 5776.191333213354, 5812.564057695689, 5316.308879845596, 5317.73411329432, 5328.413874473805, 5333.146696528537, 5371.435999220025, 5710.600257981901, 5710.857228569319, 5802.883942321215, 5870.765169393262, 5876.026885735623, 5597.524210442077, 5612.691301978431, 5626.85932851682, 5637.859053523613, 5655.3779084300695, 5682.687452190169, 5704.201411802351, 5706.058500347479, 5712.0860662293835, 5723.456271654186, 5536.695481748542, 5614.410486898899, 5643.209950606918, 5663.32040155184, 5663.603547751618, 5610.607257492018, 5701.543876489954, 5740.54075673945, 5745.195672605755, 5750.913736293959, 4740.7392593407, 4741.928871066937, 4758.405199350082, 4759.524047595282, 4783.4499032611, 4102.3026085565525, 4105.261053010487, 4110.588941105865, 4119.732217405859, 4157.064660451435, 4654.25531914892, 4713.6936099153445, 4720.669553131316, 4751.0, 4835.492273311322, 5731.828045158652, 5781.797637082682, 5792.073268277056, 5808.419158084158, 5810.128480727924, 4817.879553011133, 4818.0, 4830.782614782343, 4832.540908613676, 4862.8784280392565, 4934.432540257916, 5027.245913112989, 5031.773570189277, 5041.546260836469, 5060.873478163076, 5218.55642270396, 5294.549963253013, 5325.840224793263, 5365.38298095724, 5401.1088170453, 5616.887662246814, 5665.348484924287, 5704.144378343116, 5773.826785196451, 5810.389909059488, 5351.357837059578, 5361.410244873139, 5380.650257733391, 5398.676079435247, 5404.32445944257, 5551.639143455824, 5648.774049037993, 5655.7172141393585, 5661.631993920382, 5672.943270567242, 5601.831945041656, 5681.17622944679, 5688.146777983336, 5781.94218057814, 5797.0, 5482.369527504388, 5572.804951826666, 5590.692511911884, 5591.776328946959, 5610.074337734228, 5450.618456707993, 5477.67133971963, 5486.533644640251, 5501.119820828648, 5501.284832971688, 5359.678419294854, 5364.946350536601, 5410.918836217538, 5417.160340147283, 5459.181122831607, 5418.4852439019805, 5486.067368547277, 5491.066518691752, 5496.587755918402, 5627.493525582717, 5439.700816455133, 5470.507654311131, 5475.835724928259, 5505.0, 5507.944920550904], "value": 5168.808691236705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.9168853893264, 727.2073439950454, 757.821911850715, 1213.4418167642884, 1244.0731654917088, 35152.47271290929, 36208.27583448329, 36242.27515449689, 36242.550297988084, 36387.81806090966, 34335.656643433555, 34712.47931281033, 34785.30429391411, 34799.82600086996, 34832.651673483255, 6445.387688169628, 6683.498737594676, 6811.182658081012, 6811.863762724743, 6842.555233909805, 6692.23039350476, 6749.325067493236, 6754.628495432749, 6772.72909083636, 6781.525293229476, 6750.93249067508, 6788.2193547742145, 6798.932010679904, 6800.455963522906, 6818.9659051704675, 6725.932740672604, 6772.72909083641, 6789.18529776425, 6796.6941487632685, 6800.081988931505, 6733.797986060426, 6733.9326606734285, 6792.864142717168, 6797.2523022467485, 6802.761903333359, 32209.677903221138, 32279.193020174447, 32296.19259518507, 32313.676863231536, 32352.0, 2983.298924752703, 2986.7610591152657, 3004.053723077224, 3007.9548806767916, 3018.4868572342534, 24420.63369049466, 24425.145119920897, 24497.63253551198, 24521.50956980868, 24552.631710524358, 3025.3495498467714, 3049.4663433898977, 3060.02079334613, 3068.8772449102007, 3079.7844150909445, 143286.0, 143769.0, 148047.0, 151538.9999999989, 152054.0, 39568.60431395649, 39614.405783913266, 39712.0, 39729.0, 39739.80130099331, 40250.0, 40587.391189132184, 40607.39088913669, 43925.56074439279, 43946.0, 11295.49170287339, 11360.48877800501, 11388.487518061542, 11491.77016459666, 11496.022838058692, 8723.214910658071, 8753.868691969625, 8764.21122099014, 8830.514321712239, 8840.204381605687, 12729.172603780724, 12935.417906194056, 12938.741225175632, 12946.0, 13046.0, 5313.149896016619, 5322.2548843161985, 5328.946710532845, 5473.17902314656, 5490.752916118784, 853.1681610429781, 901.0358915959991, 904.380499357942, 907.4237858959608, 929.5816882402946, 20701.68947465789, 21288.574228515652, 21482.78517214839, 21588.244411445525, 21839.344819655435, 964.8600952861796, 976.2043934193609, 989.2086330935223, 993.6770549571419, 1005.5475036233724, 11016.889831101747, 11528.59649912249, 14137.363818628186, 14652.413903443956, 14847.109173449628, 176621.0, 178352.0, 179070.0, 180184.0, 180351.0, 44089.0, 44160.77919610382, 44255.77872110619, 44397.89005274829, 44551.331730024074, 1174.9471273792528, 1201.789686804823, 1219.7255617485994, 1230.4278510492663, 1232.4022848918266, 24172.39569010789, 24644.753552464244, 25436.0, 25555.744442555337, 25852.22443326703, 30751.53872691956, 31017.534736978512, 31241.37517249688, 31291.0, 31337.373252534366, 160526.0, 160772.0, 160911.1954440267, 161108.0, 161128.0, 28703.282417939718, 28777.136685899455, 28879.5668064975, 29655.703442965296, 30902.381952361276, 37319.81340093282, 37495.2500949974, 37564.62435375611, 37581.0, 37584.43623345597, 26952.595711064743, 27940.860295699204, 28027.43945121127, 28864.0, 29261.85369073141, 27365.0, 27843.303917402227, 28378.57432138478, 28677.13968580946, 29101.0, 31191.532127017657, 31356.216094597818, 31394.372112558078, 31431.52852707257, 31516.684833152292, 26474.867625661747, 26780.330491737863, 27082.72917270802, 27247.72752272452, 27980.160595182177, 21528.0, 22288.0, 22539.5492090154, 22579.0, 22637.320880373616], "value": 14688.560854131518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.804392913366, 414.8589479576945, 424.8067129456098, 432.49398204101203, 441.8343121329501, 11494.540218391254, 13419.0, 17368.565785855346, 17969.101544922767, 18118.184681689338, 14007.719845603082, 17900.28398864044, 18061.548461288476, 18120.285341504994, 18409.17158727857, 5390.946090539093, 5631.7747290108555, 5660.29246344207, 5684.914726279109, 5693.032184528619, 5334.679919204841, 5441.483059109379, 5446.1558458439, 5483.067878460672, 5490.094134467828, 5376.489233522829, 5389.892202155955, 5392.622516423852, 5395.81114660987, 5403.756830942597, 5366.785328586851, 5373.946260537384, 5417.295751552293, 5541.639793413416, 5610.523105535994, 4995.300657907896, 5003.649744517885, 5026.170681837492, 5034.949650503485, 5038.143515602356, 21900.342989710334, 22025.779742202532, 22544.210952616744, 22619.208327708617, 22692.0, 1587.5554844643402, 1642.0558179046977, 1655.3626853661306, 1663.0271291294607, 1663.609051872809, 13722.519711810039, 13898.0, 14035.929820350935, 14267.286635668175, 14302.92848535761, 2001.599680063993, 2048.98975505123, 2055.1162999910034, 2091.243355581319, 2120.756113047004, 87514.5624271881, 88172.11827881703, 90068.0, 90301.0, 92161.53919230428, 10817.891821081688, 10897.782044359068, 10918.617848375428, 11079.32147585442, 11201.495932683049, 15338.463153789564, 15355.846441535441, 15369.231538423033, 15393.153376564173, 15487.690246195012, 7256.637168141572, 7355.668994895243, 7395.926040739631, 7488.812779680552, 7502.737404190827, 6577.539572229898, 6651.201855777338, 6795.116634837439, 6821.0, 6842.623655698984, 6793.830154246085, 6883.931160688429, 6958.547694399847, 6975.9302406975285, 7015.228324884259, 2062.958740825175, 2063.9484012899497, 2074.284371891695, 2092.5187206942182, 2211.734591848988, 833.8374017066614, 858.3819649852096, 861.0, 863.9481631102154, 889.5818965086399, 16509.422170224225, 16711.582210444594, 16968.15159242033, 17126.314947402214, 17375.0, 858.9484630922165, 868.3443999780126, 876.2770714160843, 885.2652298592153, 889.7908991387019, 9215.53922303882, 9258.213051890665, 9474.884139997781, 9501.857472137923, 9562.378445401027, 351594.0, 354212.0, 356663.0, 360489.0, 363319.0, 71125.2887471129, 72027.63986180036, 73702.26297737061, 77355.61322193466, 79741.0, 1040.552562398176, 1043.5564884923876, 1072.0030371754187, 1098.6484325016079, 1098.906592939593, 16797.748033779746, 18184.0, 18954.715679265097, 19145.712814308074, 19214.80785192186, 39624.80187599044, 40274.59725402826, 40409.0, 40507.1898562033, 41065.178696425304, 51013.0, 52096.0, 52432.737836310574, 52840.73579632077, 53255.46744532505, 8269.62786674589, 8314.334853211849, 8582.957085214533, 8609.139086091342, 8763.91236087631, 12590.874091258971, 12881.549145779853, 13145.0, 13196.736065278448, 13217.206967581977, 11349.0, 11350.375729334966, 11373.0, 11604.245724027911, 11653.126015548698, 10442.947785261025, 10522.526486308288, 10604.787904241717, 10760.784784304113, 10770.192235582519, 11269.098472122374, 11333.356663283943, 11336.149788765711, 11378.43107844621, 11781.941090294493, 8118.147594502729, 8342.62235262947, 8356.832863342577, 8525.317974562144, 8668.393212475066, 11117.22179447431, 11126.55493780272, 11202.15983801202, 11290.322580645188, 11520.078393728649], "value": 8842.550965847617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.922784632922, 1357.8913686905048, 1366.8974826887986, 1368.787837885128, 1371.8353797544296, 10489.895101048987, 10902.182336324768, 10994.0, 11006.614768483105, 11401.828972565398, 11014.724631884186, 11165.38590377529, 11171.83242251365, 11201.327920324786, 11222.66332010041, 2216.279709094543, 2244.6969659095976, 2246.5731511012937, 2250.4261413339577, 2250.583642026222, 2120.54408302215, 2148.1729534129317, 2149.924752633658, 2158.5467051919036, 2162.0595041157067, 2115.7038014677955, 2154.9353519394444, 2159.3953692965993, 2161.664941934003, 2165.436986383536, 2130.4886827161527, 2132.0832042221837, 2133.3919832847564, 2137.5938571671486, 2143.8928053597256, 2073.3676228750223, 2131.914723411062, 2220.8334374921783, 2221.7444993825757, 2223.177424353, 10755.0, 10857.294275872122, 10860.782784344348, 10865.348079115278, 10874.0, 5658.632188907749, 5855.355910849803, 5855.443732845373, 5898.528117750569, 5903.0555111182, 3349.949750753741, 3512.209752805624, 3558.2883423315184, 3561.5370001899846, 3567.4113771227717, 1020.8519764634086, 1041.0474415909434, 1068.2522234435849, 1076.8923107689247, 1097.983530247047, 16047.277872495766, 16158.838411615969, 16203.91898040514, 16244.187790610422, 16262.83737162625, 4815.0, 4840.724859316116, 4931.4821943696115, 4985.177445721415, 5008.273800298936, 11756.470958806874, 11796.94101529487, 11802.881971180179, 11813.291202527877, 11834.05327573792, 5568.331800184003, 5622.269105016404, 5641.26663533738, 5678.744456499468, 5695.202671625976, 5134.820281290212, 5212.713300768418, 5214.869628259324, 5251.658642188246, 5262.2632831403635, 3928.8035598220545, 3992.680585553149, 4000.2799496090984, 4048.69634777387, 4170.958290417057, 1132.3375825142218, 1133.5239199536215, 1138.9031932285682, 1160.640201537526, 1161.7734541764444, 677.7560078371782, 701.1095908196562, 702.5293053653962, 715.7351779841388, 718.5365439291733, 5525.309336332958, 5583.106702927512, 5609.718314785896, 5632.929743348751, 5729.0, 550.3231025838242, 571.977120915167, 573.9799107031234, 851.3614788908319, 875.0418291970283, 3762.9275656437785, 3934.6065393460426, 3951.9377691346, 3957.6240257175523, 4010.1177740896956, 13562.389692463863, 13670.453181872812, 14199.503017394341, 14294.070885392417, 14369.497067602584, 13891.513797017056, 13906.721865562633, 14087.22520261375, 14160.575182744535, 14204.928975355057, 7477.364424024019, 7681.7695469136015, 7765.650545725569, 7771.805704857311, 7783.727569535039, 6318.747250109944, 6386.457151142019, 6530.151080359523, 6569.441597464269, 6634.038064480526, 12728.1726687765, 13034.869651303365, 13064.412101455648, 13077.476900923857, 13118.475260989835, 12959.740805184032, 13159.210447373189, 13311.46754129824, 13356.532521361705, 13468.461261549428, 8774.956125219333, 8913.732588022369, 9201.217896478875, 9232.122948319899, 9298.163165315154, 10511.737206569896, 10630.574777008833, 10635.680929572125, 10640.52117654692, 10667.786644267226, 8532.744017679479, 8597.441166324168, 8815.338849586178, 8935.240504556925, 8950.641974320954, 8455.0, 8545.359098067545, 8545.487270763773, 8552.401331906707, 8653.30773538128, 7808.336291415066, 7875.173106823701, 7898.565578892986, 7929.0, 7930.167332430012, 5459.908018396416, 5463.781448742165, 5534.252875861707, 5541.944580554143, 5706.28671416073, 5395.703236321883, 5396.7571459283645, 5474.644148130359, 5551.279103477935, 5663.093904975184], "value": 4908.276591890699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.5344026846978, 394.62510614915834, 399.4188455796816, 400.6814582406986, 401.2596758979681, 5369.892602147955, 5517.972410137949, 5524.751386187621, 5526.58550608704, 5542.140968149938, 5275.736213189344, 5368.409474957752, 5380.461953804617, 5384.5692344612435, 5388.515033646981, 4119.361498967664, 4121.855735049274, 4126.277901367263, 4132.855350062749, 4141.494395890488, 3974.642282194602, 4106.835726570934, 4136.172765446908, 4142.316517774579, 4146.253674338618, 4093.9385909211387, 4095.5904409558952, 4111.321631930728, 4112.074783173792, 4116.608922152391, 4084.7344922580232, 4085.305498065351, 4093.9795301023305, 4094.7338423002557, 4110.445089912853, 3459.8789042383396, 3624.9456258156147, 3638.6543278388776, 3643.344198044351, 3652.2330310634798, 5266.683998960037, 5293.39126000511, 5303.36359636846, 5309.283246761676, 5316.229146773735, 4785.21044027735, 4821.638377121695, 4825.7587120644175, 4832.589229915461, 4836.443808961944, 5520.0, 5605.20633397313, 5634.577406694514, 5706.231068368819, 5717.342505611867, 4061.675065994743, 4070.3283958147167, 4071.246819338432, 4077.612626800449, 4098.4876890388705, 5798.652080875161, 6002.909956350614, 6033.276006879202, 6045.3652366501765, 6117.143599896018, 4084.8366065357645, 4100.0, 4100.0569868930315, 4110.712250142461, 4125.793710314472, 4157.752674197729, 4161.417401563784, 4164.292070348048, 4167.666586673059, 4174.227767862894, 4674.6026587740425, 4738.455077666113, 4759.524047595212, 4768.880777980509, 4787.904241915142, 5733.856653583611, 5750.539956803445, 5755.884882302331, 5758.165066065397, 5772.913406298909, 1415.7027024325007, 1419.936102875373, 1422.49501426994, 1426.6362077670128, 1427.293489722594, 923.0492592629603, 984.6504490905769, 987.9110880020833, 989.0702739424918, 993.1260490768078, 4899.314096026559, 4911.631627627942, 4951.935333903228, 4957.256411538298, 4972.229304457815, 5906.0, 5909.113632955091, 5923.466887980103, 5926.2295901532525, 5929.436703513159, 4690.882727931761, 4858.854234372974, 4888.608911287089, 4898.975505122452, 4910.435299940553, 3101.457244982119, 3137.7803553751473, 3139.937201255962, 3145.0, 3146.1819926818735, 5469.671819690831, 5518.475744804237, 5551.000819852385, 5554.250176226238, 5554.666719996813, 5994.310654274727, 6021.2473440819895, 6048.364921683248, 6050.2437195350585, 6102.389761023862, 5522.66863988154, 5525.944740552623, 5534.142207957773, 5538.47384498472, 5544.7782088716, 5666.376698563073, 5871.506453660066, 5932.733027013881, 5944.851378715567, 5972.8805423892145, 5876.735546900314, 5880.442007726652, 5894.705264736832, 5896.528277737685, 5911.290645122613, 5378.704171270618, 5512.39363669988, 5556.305461817273, 5556.694381809039, 5601.039636127322, 4157.688173387069, 4157.729747566398, 4179.414881916595, 4184.267753143127, 4190.916181676411, 5844.824655260349, 6007.146605362593, 6016.338202797601, 6025.367336429612, 6031.306399763907, 5755.453231942959, 5759.280089988752, 5777.971110144423, 5786.161006654096, 5789.45000224978, 5735.71321433935, 5775.9133612995, 5777.480026797609, 5778.595498315078, 5788.131780232999, 5458.836234912959, 5662.348829884451, 5694.259746232963, 5706.657600543981, 5724.713764311685, 5762.250907382014, 5797.869415463944, 5807.564432667482, 5809.796657116981, 5818.534517238526, 5511.834644960658, 5591.608587398843, 5641.971790141023, 5650.180723795109, 5658.490735833795], "value": 4303.2225222239285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.5291290030835, 751.9887201691972, 757.7688804914501, 763.8281386687993, 776.9339606133476, 13488.0, 14425.783613245796, 14459.349329280181, 15607.375704971815, 16983.57541061474, 16708.916455417737, 16778.0, 16948.406805761802, 16970.915145424256, 16998.235079421425, 845.8266055458616, 877.1929824561403, 897.4121950122648, 902.0933961368848, 903.336048004716, 890.1187824054172, 891.6477991193475, 892.6474042753109, 895.1630225738955, 896.8027034052498, 938.6104766521885, 939.8684184214181, 940.196132306878, 942.4439580647417, 944.7496413450441, 941.5998200764716, 942.1002942190192, 942.7831598732262, 943.1652987106426, 948.1135138645388, 683.0607914118087, 689.1454596300551, 691.3432239372617, 692.560224257595, 696.022088965005, 14909.850901490954, 15285.388584456608, 15402.306896189699, 15419.460318888898, 15436.691266174726, 16386.918065409598, 16694.58263543421, 16698.165091745363, 16791.66416671672, 16815.0751708656, 12548.435320410512, 13057.281849498273, 13089.934550327283, 13241.933790330986, 13288.933555332162, 3030.212144842335, 3033.0294305822144, 3044.756419486436, 3046.908592742221, 3063.0657649416917, 83160.0, 86064.56967715184, 86761.56619216864, 87832.99999999936, 88375.11624883734, 12031.939840300918, 12292.323922184365, 12481.126321157431, 12528.0, 12623.305718185404, 20240.696389554167, 20382.592348152953, 20451.0, 20469.692954605693, 20531.178752850017, 5915.733791979371, 6081.118237855575, 6081.179040829431, 6102.542309326818, 6107.358727333566, 2978.508546089914, 3038.8176709397067, 3042.4827779277575, 3048.481758101128, 3051.7182783231096, 3874.1670540833857, 3953.3081710700512, 3956.802159891994, 3971.483707118114, 3980.522337319482, 707.8230442389403, 716.3266529462289, 717.2003216413661, 718.3714250031222, 719.0329007484925, 526.3000209721062, 537.5511447940935, 596.9731362088717, 619.8729260501586, 626.1828314050208, 9929.801403972024, 10026.248031397528, 10423.478826058667, 11013.669589912315, 11304.15218858589, 616.6669998201011, 617.4813156948095, 620.2835724737935, 625.1123404765244, 630.2153818496001, 4597.770111494478, 4712.740799256074, 4792.544708252711, 4915.115279249698, 4918.877028074256, 80936.0, 82155.0, 82341.58829205936, 83883.58058209669, 84468.57765711132, 76016.0, 76449.23550764532, 77026.0, 77927.0, 78598.6070069646, 64734.676326618064, 67482.0, 67915.3208467909, 67960.66019669968, 68993.31006689869, 10262.692119236435, 10461.633842815465, 11243.212975091992, 11249.775004500028, 11424.714382140513, 27385.45229095447, 27551.31121721893, 27602.723972760818, 29089.7091029087, 29588.852055740444, 50286.0, 51253.0, 51254.231186531484, 51702.0, 53584.73207634093, 14911.925440372728, 14916.701665966837, 15441.0735355879, 15448.768268475756, 15538.611534711723, 16225.350985960902, 16746.246418910934, 16864.409745658842, 16880.915595421946, 17045.31818727237, 14292.428302868184, 14831.703365932837, 15450.613734656723, 15702.685946281239, 15743.842561574696, 15121.546353609408, 15465.536033919001, 15806.130662813655, 15837.841621584097, 16106.27521761547, 14553.708925821637, 14956.850431495546, 15430.151341676315, 15462.690746185239, 15625.765613516034, 11264.605738799102, 11303.491342889754, 11390.829137562778, 11508.654740357802, 11945.283283003047, 11640.94179529097, 11938.641840744443, 12121.575744848888, 12162.998761832361, 12323.50705971751], "value": 7374.1726108713165, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 111.0, 109.0, 110.0, 111.0, 111.0, 112.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 123.0, 168.0, 122.0, 124.0, 124.0, 122.0, 151.0, 127.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 166.0, 167.0, 167.0, 175.0, 165.0, 164.0, 166.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 109.0, 78.0, 79.0, 74.0, 75.0, 96.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 109.0, 83.0, 83.0, 82.0, 102.0, 83.0, 83.0, 108.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 151.0, 151.0, 151.0, 152.0, 151.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 96.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 59.0, 65.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 86.0, 87.0, 87.0, 86.0, 89.0, 98.0, 125.0, 96.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 143.0, 132.0, 146.0, 132.0, 143.0, 135.0, 135.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 196.0, 199.0, 194.0, 192.0, 187.0, 194.0, 187.0, 200.0, 188.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 72.0, 71.0, 74.0, 71.0, 70.0, 74.0, 74.0, 77.0], "value": 73.4, "unit": "score"}]}]} 09:07:46 INFO - Return code: 0 09:07:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:07:46 INFO - # TBPL SUCCESS # 09:07:46 INFO - Running post-action listener: _resource_record_post_action 09:07:46 INFO - [mozharness: 2017-05-29 16:07:46.954606Z] Finished run-tests step (success) 09:07:46 INFO - Running post-run listener: _resource_record_post_run 09:07:47 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 0; Write bytes: 404320256; Read time: 0; Write time: 314484 09:07:47 INFO - TinderboxPrint: CPU usage
12.7% 09:07:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:07:47 INFO - TinderboxPrint: I/O write bytes / time
404,320,256 / 314,484 09:07:47 INFO - TinderboxPrint: CPU idle
8,768.1 (87.3%) 09:07:47 INFO - TinderboxPrint: CPU user
1,219.4 (12.1%) 09:07:47 INFO - TinderboxPrint: Swap in / out
0 / 0 09:07:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 97648640; Read time: 0; Write time: 99644 09:07:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:07:47 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 0; Write bytes: 306671616; Read time: 0; Write time: 214840 09:07:47 INFO - Running post-run listener: _upload_blobber_files 09:07:47 INFO - Blob upload gear active. 09:07:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:47 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 09:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:07:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:48 INFO - (blobuploader) - INFO - Done attempting. 09:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:49 INFO - (blobuploader) - INFO - Done attempting. 09:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:50 INFO - (blobuploader) - INFO - Done attempting. 09:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:07:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:57 INFO - (blobuploader) - INFO - Done attempting. 09:07:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:57 INFO - Return code: 0 09:07:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e9b73be699727ba67875b65df8252f6eecf65635ae8b05112508c764dcffdfa16e3ee1a357daf570b51fe44927f5645b95a292a1e3545528747e655b7c5b32", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52708173eb86f91ed46f82469f936a2cf6d0a7d5f60ef8dc2eec5d5d7963234a3940e1c14a9c0c6c50b16ceb21ab82b7180dcae5c1e6ec69ffde051a18076563", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f548571fa10ee16de929ed619fdd246cb4469e36de25c9c3ecfa1c04f68231de06a374685dedb98950aaa99181df629bfcd4ba3a79db37d5f39868cbbc03c7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b77765513a530c3e1923f4a1eb69b9141160dd86a1357b18cd6bcc94ad696239dffee17565f5e38c20b3f8aeb3003143548e6e7a4d521904337c19daba62a06"} 09:07:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:57 INFO - Contents: 09:07:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e9b73be699727ba67875b65df8252f6eecf65635ae8b05112508c764dcffdfa16e3ee1a357daf570b51fe44927f5645b95a292a1e3545528747e655b7c5b32", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52708173eb86f91ed46f82469f936a2cf6d0a7d5f60ef8dc2eec5d5d7963234a3940e1c14a9c0c6c50b16ceb21ab82b7180dcae5c1e6ec69ffde051a18076563", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f548571fa10ee16de929ed619fdd246cb4469e36de25c9c3ecfa1c04f68231de06a374685dedb98950aaa99181df629bfcd4ba3a79db37d5f39868cbbc03c7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b77765513a530c3e1923f4a1eb69b9141160dd86a1357b18cd6bcc94ad696239dffee17565f5e38c20b3f8aeb3003143548e6e7a4d521904337c19daba62a06"} 09:07:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:57 INFO - Copying logs to upload dir... 09:07:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.952166 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-29 09:07:56.631180) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 09:07:56.635300) ========= 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=db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e9b73be699727ba67875b65df8252f6eecf65635ae8b05112508c764dcffdfa16e3ee1a357daf570b51fe44927f5645b95a292a1e3545528747e655b7c5b32", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52708173eb86f91ed46f82469f936a2cf6d0a7d5f60ef8dc2eec5d5d7963234a3940e1c14a9c0c6c50b16ceb21ab82b7180dcae5c1e6ec69ffde051a18076563", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f548571fa10ee16de929ed619fdd246cb4469e36de25c9c3ecfa1c04f68231de06a374685dedb98950aaa99181df629bfcd4ba3a79db37d5f39868cbbc03c7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b77765513a530c3e1923f4a1eb69b9141160dd86a1357b18cd6bcc94ad696239dffee17565f5e38c20b3f8aeb3003143548e6e7a4d521904337c19daba62a06"} build_url:https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/YJcJi7eESraDPq_UXv8bJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1e9b73be699727ba67875b65df8252f6eecf65635ae8b05112508c764dcffdfa16e3ee1a357daf570b51fe44927f5645b95a292a1e3545528747e655b7c5b32", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52708173eb86f91ed46f82469f936a2cf6d0a7d5f60ef8dc2eec5d5d7963234a3940e1c14a9c0c6c50b16ceb21ab82b7180dcae5c1e6ec69ffde051a18076563", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f548571fa10ee16de929ed619fdd246cb4469e36de25c9c3ecfa1c04f68231de06a374685dedb98950aaa99181df629bfcd4ba3a79db37d5f39868cbbc03c7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b77765513a530c3e1923f4a1eb69b9141160dd86a1357b18cd6bcc94ad696239dffee17565f5e38c20b3f8aeb3003143548e6e7a4d521904337c19daba62a06"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-29 09:07:56.662466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 09:07:56.662795) ========= 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=db7e7c15f3ca076d53731445000001ba-1496070221.605853-236714782 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-29 09:07:56.743626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 09:07:56.746954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-29 09:07:56.747239) ========= ========= Total master_lag: 0.18 =========