builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1496014561.13 results: success (0) revision: 4541134e973a6bd5e667a603e844854c8e5361da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.131216) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.131623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.131904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.147035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.147289) ========= 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=cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-28 16:36:01-- 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.4M=0s 2017-05-28 16:36:01 (45.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.184794 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.347939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.348252) ========= 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=cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017262 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:01.397297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-28 16:36:01.397583) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4541134e973a6bd5e667a603e844854c8e5361da --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 4541134e973a6bd5e667a603e844854c8e5361da --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=cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-28 16:36:02,110 truncating revision to first 12 chars 2017-05-28 16:36:02,111 Setting DEBUG logging. 2017-05-28 16:36:02,111 attempt 1/10 2017-05-28 16:36:02,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4541134e973a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-28 16:36:02,828 unpacking tar archive at: mozilla-central-4541134e973a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-28 16:36:02.472148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:02.472467) ========= script_repo_revision: 4541134e973a6bd5e667a603e844854c8e5361da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:02.472859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:02.473134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:36:02.481586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-28 16:36:02.481848) ========= /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=cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:03 INFO - MultiFileLogger online at 20170528 16:36:03 in /builds/slave/test 16:36:03 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 16:36:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:03 INFO - {'append_to_log': False, 16:36:03 INFO - 'base_work_dir': '/builds/slave/test', 16:36:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:36:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:03 INFO - 'branch': 'Firefox-Non-PGO', 16:36:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:03 INFO - 'config_files': ('talos/linux_config.py',), 16:36:03 INFO - 'default_actions': ('clobber', 16:36:03 INFO - 'read-buildbot-config', 16:36:03 INFO - 'download-and-extract', 16:36:03 INFO - 'populate-webroot', 16:36:03 INFO - 'create-virtualenv', 16:36:03 INFO - 'install', 16:36:03 INFO - 'setup-mitmproxy', 16:36:03 INFO - 'run-tests'), 16:36:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:03 INFO - 'download_minidump_stackwalk': True, 16:36:03 INFO - 'download_symbols': 'ondemand', 16:36:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:03 INFO - 'gecko_profile': False, 16:36:03 INFO - 'gecko_profile_interval': 0, 16:36:03 INFO - 'installer_path': 'installer.exe', 16:36:03 INFO - 'log_level': 'info', 16:36:03 INFO - 'log_name': 'talos', 16:36:03 INFO - 'log_to_console': True, 16:36:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:03 INFO - 'opt_config_files': (), 16:36:03 INFO - 'pip_index': False, 16:36:03 INFO - 'suite': 'dromaeojs-e10s', 16:36:03 INFO - 'system_bits': '32', 16:36:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:03 INFO - 'title': 'talos-linux64-ix-054', 16:36:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:03 INFO - 'use_talos_json': True, 16:36:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:03 INFO - 'work_dir': 'build'} 16:36:03 INFO - [mozharness: 2017-05-28 23:36:03.289788Z] Running clobber step. 16:36:03 INFO - Running pre-action listener: _resource_record_pre_action 16:36:03 INFO - Running main action method: clobber 16:36:03 INFO - rmtree: /builds/slave/test/build 16:36:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:04 INFO - Running post-action listener: _resource_record_post_action 16:36:04 INFO - [mozharness: 2017-05-28 23:36:04.325770Z] Finished clobber step (success) 16:36:04 INFO - [mozharness: 2017-05-28 23:36:04.325872Z] Running read-buildbot-config step. 16:36:04 INFO - Running pre-action listener: _resource_record_pre_action 16:36:04 INFO - Running main action method: read_buildbot_config 16:36:04 INFO - Using buildbot properties: 16:36:04 INFO - { 16:36:04 INFO - "project": "", 16:36:04 INFO - "product": "firefox", 16:36:04 INFO - "who": "archaeopteryx@coole-files.de", 16:36:04 INFO - "installer_path": "public/build/target.tar.bz2", 16:36:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:36:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:36:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:36:04 INFO - "stage_platform": "linux64", 16:36:04 INFO - "basedir": "/builds/slave/test", 16:36:04 INFO - "buildnumber": 642, 16:36:04 INFO - "platform": "ubuntu64_hw", 16:36:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:36:04 INFO - "slavebuilddir": "test", 16:36:04 INFO - "taskId": "d42LVcdrThq5o3uoIbhMfw", 16:36:04 INFO - "branch": "mozilla-central", 16:36:04 INFO - "script_repo_revision": "production", 16:36:04 INFO - "revision": "4541134e973a6bd5e667a603e844854c8e5361da", 16:36:04 INFO - "slavename": "talos-linux64-ix-054", 16:36:04 INFO - "repo_path": "mozilla-central" 16:36:04 INFO - } 16:36:04 INFO - Finding installer, test and symbols from parent task. 16:36:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d42LVcdrThq5o3uoIbhMfw'}, attempt #1 16:36:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d42LVcdrThq5o3uoIbhMfw'}, attempt #1 16:36:05 INFO - Task dependencies: Zq31C-D7RQq1qgmmXvoCbQ 16:36:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ'}, attempt #1 16:36:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2 16:36:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/test_packages.json 16:36:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.crashreporter-symbols.zip 16:36:05 INFO - Running post-action listener: _resource_record_post_action 16:36:05 INFO - [mozharness: 2017-05-28 23:36:05.703058Z] Finished read-buildbot-config step (success) 16:36:05 INFO - [mozharness: 2017-05-28 23:36:05.703279Z] Running download-and-extract step. 16:36:05 INFO - Running pre-action listener: _resource_record_pre_action 16:36:05 INFO - Running main action method: download_and_extract 16:36:05 INFO - mkdir: /builds/slave/test/build/tests 16:36:05 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')]} 16:36:05 INFO - trying https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.test_packages.json 16:36:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:36:06 INFO - Downloaded 986 bytes. 16:36:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:36:06 INFO - Using the following test package requirements: 16:36:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:36:06 INFO - u'common': [u'target.common.tests.zip'], 16:36:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:36:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:36:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:36:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:36:06 INFO - u'mozbase': [u'target.common.tests.zip'], 16:36:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:36:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:36:06 INFO - u'web-platform': [u'target.common.tests.zip', 16:36:06 INFO - u'target.web-platform.tests.zip'], 16:36:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:36:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:36:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.common.tests.zip 16:36:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:36:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.common.tests.zip into memory 16:36:07 INFO - Content-Length response header: 63527376 16:36:07 INFO - Bytes received: 63527376 16:36:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.common.tests.zip 16:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.common.tests.zip into memory 16:36:19 INFO - Content-Length response header: 63527376 16:36:19 INFO - Bytes received: 63527376 16:36:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.talos.tests.zip 16:36:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:36:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.talos.tests.zip into memory 16:36:32 INFO - Content-Length response header: 14447425 16:36:32 INFO - Bytes received: 14447425 16:36: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')]} 16:36:32 INFO - trying https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2 16:36:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:36:33 INFO - Downloaded 54274815 bytes. 16:36:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2 16:36:33 INFO - mkdir: /builds/slave/test/properties 16:36:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:33 INFO - Contents: 16:36:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2 16:36:33 INFO - Running post-action listener: _resource_record_post_action 16:36:33 INFO - Running post-action listener: set_extra_try_arguments 16:36:33 INFO - [mozharness: 2017-05-28 23:36:33.885256Z] Finished download-and-extract step (success) 16:36:33 INFO - [mozharness: 2017-05-28 23:36:33.885504Z] Running populate-webroot step. 16:36:33 INFO - Running pre-action listener: _resource_record_pre_action 16:36:33 INFO - Running main action method: populate_webroot 16:36:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:33 INFO - '--tppagecycles', 16:36:33 INFO - '7'], 16:36:33 INFO - 'tests': ['tsvgm']}}, 16:36:33 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:36:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:36:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:36:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['damp', 'tps']}, 16:36:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'tests': ['damp', 'tps']}, 16:36:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['dromaeo_dom']}, 16:36:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:36:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:36:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:36:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['a11yr', 16:36:33 INFO - 'ts_paint', 16:36:33 INFO - 'tpaint', 16:36:33 INFO - 'sessionrestore', 16:36:33 INFO - 'sessionrestore_no_auto_restore', 16:36:33 INFO - 'tabpaint']}, 16:36:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:36:33 INFO - 'ts_paint', 16:36:33 INFO - 'tpaint', 16:36:33 INFO - 'sessionrestore', 16:36:33 INFO - 'sessionrestore_no_auto_restore', 16:36:33 INFO - 'tabpaint']}, 16:36:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:36:33 INFO - 'ts_paint', 16:36:33 INFO - 'tpaint', 16:36:33 INFO - 'sessionrestore', 16:36:33 INFO - 'sessionrestore_no_auto_restore', 16:36:33 INFO - 'tabpaint']}, 16:36:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:36:33 INFO - 'ts_paint', 16:36:33 INFO - 'tpaint', 16:36:33 INFO - 'sessionrestore', 16:36:33 INFO - 'sessionrestore_no_auto_restore', 16:36:33 INFO - 'tabpaint']}, 16:36:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['a11yr', 16:36:33 INFO - 'ts_paint', 16:36:33 INFO - 'tpaint', 16:36:33 INFO - 'sessionrestore', 16:36:33 INFO - 'sessionrestore_no_auto_restore', 16:36:33 INFO - 'tabpaint']}, 16:36:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['a11yr', 16:36:33 INFO - 'ts_paint', 16:36:33 INFO - 'tpaint', 16:36:33 INFO - 'sessionrestore', 16:36:33 INFO - 'sessionrestore_no_auto_restore', 16:36:33 INFO - 'tabpaint']}, 16:36:33 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:36:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:36:33 INFO - 'bloom_basic_ref']}, 16:36:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:36:33 INFO - 'talos_options': ['--mitmproxy', 16:36:33 INFO - 'mitmproxy-recording-1.mp', 16:36:33 INFO - '--firstNonBlankPaint'], 16:36:33 INFO - 'tests': ['Quantum_1']}, 16:36:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['tsvgx', 16:36:33 INFO - 'tsvgr_opacity', 16:36:33 INFO - 'tart', 16:36:33 INFO - 'tscrollx', 16:36:33 INFO - 'cart', 16:36:33 INFO - 'tsvg_static']}, 16:36:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:36:33 INFO - 'tsvgr_opacity', 16:36:33 INFO - 'tart', 16:36:33 INFO - 'tscrollx', 16:36:33 INFO - 'cart', 16:36:33 INFO - 'tsvg_static']}, 16:36:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'talos_options': ['--disable-e10s'], 16:36:33 INFO - 'tests': ['tp5o']}, 16:36:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:36:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'talos_options': ['--disable-e10s', 16:36:33 INFO - '--xperf_path', 16:36:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:33 INFO - 'tests': ['tp5n']}, 16:36:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:36:33 INFO - 'talos_options': ['--xperf_path', 16:36:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:33 INFO - 'tests': ['tp5n']}}, 16:36:33 INFO - 'talos.zip': {'path': '', 16:36:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:33 INFO - Running post-action listener: _resource_record_post_action 16:36:33 INFO - [mozharness: 2017-05-28 23:36:33.902157Z] Finished populate-webroot step (success) 16:36:33 INFO - [mozharness: 2017-05-28 23:36:33.902252Z] Running create-virtualenv step. 16:36:33 INFO - Running pre-action listener: _resource_record_pre_action 16:36:33 INFO - Running main action method: create_virtualenv 16:36:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:33 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 16:36:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:33 INFO - Using real prefix '/usr' 16:36:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:36 INFO - Installing pip.................done. 16:36:36 INFO - Return code: 0 16:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:36:36 INFO - Reading from file tmpfile_stdout 16:36:36 INFO - Output received: 16:36:36 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) 16:36:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:36:36 INFO - Using env: {'DISPLAY': ':0', 16:36:36 INFO - 'HOME': '/home/cltbld', 16:36:36 INFO - 'LANG': 'en_US.UTF-8', 16:36:36 INFO - 'LANGUAGE': 'en_US:en', 16:36:36 INFO - 'LOGNAME': 'cltbld', 16:36:36 INFO - 'MAIL': '/var/mail/cltbld', 16:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:36 INFO - 'MOZ_NO_REMOTE': '1', 16:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:36 INFO - 'NO_EM_RESTART': '1', 16:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:36 INFO - 'PWD': '/builds/slave/test', 16:36:36 INFO - 'SHELL': '/bin/bash', 16:36:36 INFO - 'SHLVL': '1', 16:36:36 INFO - 'TERM': 'linux', 16:36:36 INFO - 'TMOUT': '86400', 16:36:36 INFO - 'USER': 'cltbld', 16:36:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:36 INFO - '_': '/tools/buildbot/bin/python'} 16:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:36 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 16:36:36 INFO - Cleaning up... 16:36:36 INFO - Return code: 0 16:36:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:36:36 INFO - Using env: {'DISPLAY': ':0', 16:36:36 INFO - 'HOME': '/home/cltbld', 16:36:36 INFO - 'LANG': 'en_US.UTF-8', 16:36:36 INFO - 'LANGUAGE': 'en_US:en', 16:36:36 INFO - 'LOGNAME': 'cltbld', 16:36:36 INFO - 'MAIL': '/var/mail/cltbld', 16:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:36 INFO - 'MOZ_NO_REMOTE': '1', 16:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:36 INFO - 'NO_EM_RESTART': '1', 16:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:36 INFO - 'PWD': '/builds/slave/test', 16:36:36 INFO - 'SHELL': '/bin/bash', 16:36:36 INFO - 'SHLVL': '1', 16:36:36 INFO - 'TERM': 'linux', 16:36:36 INFO - 'TMOUT': '86400', 16:36:36 INFO - 'USER': 'cltbld', 16:36:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:36 INFO - '_': '/tools/buildbot/bin/python'} 16:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:37 INFO - Downloading/unpacking psutil>=3.1.1 16:36: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 16:36: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 16:36: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 16:36: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 16:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:38 INFO - Installing collected packages: psutil 16:36:38 INFO - Running setup.py install for psutil 16:36:38 INFO - building 'psutil._psutil_linux' extension 16:36:38 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 16:36:38 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 16:36:38 INFO - building 'psutil._psutil_posix' extension 16:36:38 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 16:36:38 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 16:36:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:38 INFO - Successfully installed psutil 16:36:38 INFO - Cleaning up... 16:36:38 INFO - Return code: 0 16:36:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:36:38 INFO - Using env: {'DISPLAY': ':0', 16:36:38 INFO - 'HOME': '/home/cltbld', 16:36:38 INFO - 'LANG': 'en_US.UTF-8', 16:36:38 INFO - 'LANGUAGE': 'en_US:en', 16:36:38 INFO - 'LOGNAME': 'cltbld', 16:36:38 INFO - 'MAIL': '/var/mail/cltbld', 16:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:38 INFO - 'MOZ_NO_REMOTE': '1', 16:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:38 INFO - 'NO_EM_RESTART': '1', 16:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:38 INFO - 'PWD': '/builds/slave/test', 16:36:38 INFO - 'SHELL': '/bin/bash', 16:36:38 INFO - 'SHLVL': '1', 16:36:38 INFO - 'TERM': 'linux', 16:36:38 INFO - 'TMOUT': '86400', 16:36:38 INFO - 'USER': 'cltbld', 16:36:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:38 INFO - '_': '/tools/buildbot/bin/python'} 16:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:36: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 16:36: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 16:36: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 16:36: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 16:36:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:36:40 INFO - Installing collected packages: mozsystemmonitor 16:36:40 INFO - Running setup.py install for mozsystemmonitor 16:36:40 INFO - Successfully installed mozsystemmonitor 16:36:40 INFO - Cleaning up... 16:36:40 INFO - Return code: 0 16:36:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36: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')]} 16:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:40 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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:40 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 16:36:40 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 16:36:40 INFO - Using env: {'DISPLAY': ':0', 16:36:40 INFO - 'HOME': '/home/cltbld', 16:36:40 INFO - 'LANG': 'en_US.UTF-8', 16:36:40 INFO - 'LANGUAGE': 'en_US:en', 16:36:40 INFO - 'LOGNAME': 'cltbld', 16:36:40 INFO - 'MAIL': '/var/mail/cltbld', 16:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:40 INFO - 'MOZ_NO_REMOTE': '1', 16:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:40 INFO - 'NO_EM_RESTART': '1', 16:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:40 INFO - 'PWD': '/builds/slave/test', 16:36:40 INFO - 'SHELL': '/bin/bash', 16:36:40 INFO - 'SHLVL': '1', 16:36:40 INFO - 'TERM': 'linux', 16:36:40 INFO - 'TMOUT': '86400', 16:36:40 INFO - 'USER': 'cltbld', 16:36:40 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:40 INFO - '_': '/tools/buildbot/bin/python'} 16:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:36:40 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 16:36:40 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 16:36:40 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 16:36:40 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 16:36:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:36:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:41 INFO - Downloading functools32-3.2.3-2.tar.gz 16:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:36:41 INFO - warning: no files found matching '*.txt' 16:36:41 INFO - no previously-included directories found matching 'build' 16:36:41 INFO - no previously-included directories found matching 'dist' 16:36:41 INFO - no previously-included directories found matching '.git*' 16:36:41 INFO - Installing collected packages: jsonschema, functools32 16:36:41 INFO - Running setup.py install for functools32 16:36:41 INFO - warning: no files found matching '*.txt' 16:36:41 INFO - no previously-included directories found matching 'build' 16:36:41 INFO - no previously-included directories found matching 'dist' 16:36:41 INFO - no previously-included directories found matching '.git*' 16:36:41 INFO - Successfully installed jsonschema functools32 16:36:41 INFO - Cleaning up... 16:36:42 INFO - Return code: 0 16:36:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:36:42 INFO - Using env: {'DISPLAY': ':0', 16:36:42 INFO - 'HOME': '/home/cltbld', 16:36:42 INFO - 'LANG': 'en_US.UTF-8', 16:36:42 INFO - 'LANGUAGE': 'en_US:en', 16:36:42 INFO - 'LOGNAME': 'cltbld', 16:36:42 INFO - 'MAIL': '/var/mail/cltbld', 16:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:42 INFO - 'MOZ_NO_REMOTE': '1', 16:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:42 INFO - 'NO_EM_RESTART': '1', 16:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:42 INFO - 'PWD': '/builds/slave/test', 16:36:42 INFO - 'SHELL': '/bin/bash', 16:36:42 INFO - 'SHLVL': '1', 16:36:42 INFO - 'TERM': 'linux', 16:36:42 INFO - 'TMOUT': '86400', 16:36:42 INFO - 'USER': 'cltbld', 16:36:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:42 INFO - '_': '/tools/buildbot/bin/python'} 16:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:36:42 INFO - Cleaning up... 16:36:42 INFO - Return code: 0 16:36:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:36:42 INFO - Using env: {'DISPLAY': ':0', 16:36:42 INFO - 'HOME': '/home/cltbld', 16:36:42 INFO - 'LANG': 'en_US.UTF-8', 16:36:42 INFO - 'LANGUAGE': 'en_US:en', 16:36:42 INFO - 'LOGNAME': 'cltbld', 16:36:42 INFO - 'MAIL': '/var/mail/cltbld', 16:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:42 INFO - 'MOZ_NO_REMOTE': '1', 16:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:42 INFO - 'NO_EM_RESTART': '1', 16:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:42 INFO - 'PWD': '/builds/slave/test', 16:36:42 INFO - 'SHELL': '/bin/bash', 16:36:42 INFO - 'SHLVL': '1', 16:36:42 INFO - 'TERM': 'linux', 16:36:42 INFO - 'TMOUT': '86400', 16:36:42 INFO - 'USER': 'cltbld', 16:36:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:42 INFO - '_': '/tools/buildbot/bin/python'} 16:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:42 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 16:36:42 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 16:36:42 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 16:36:42 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 16:36:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:43 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 16:36:43 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 16:36:43 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 16:36:43 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 16:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:43 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 16:36:43 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 16:36:43 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 16:36:43 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 16:36:44 INFO - Downloading docopt-0.6.1.tar.gz 16:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:44 INFO - Running setup.py install for blobuploader 16:36:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:44 INFO - Running setup.py install for requests 16:36:44 INFO - Running setup.py install for docopt 16:36:44 INFO - Successfully installed blobuploader requests docopt 16:36:44 INFO - Cleaning up... 16:36:44 INFO - Return code: 0 16:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:44 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')]} 16:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:44 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')]} 16:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:44 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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:44 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 16:36:44 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 16:36:44 INFO - Using env: {'DISPLAY': ':0', 16:36:44 INFO - 'HOME': '/home/cltbld', 16:36:44 INFO - 'LANG': 'en_US.UTF-8', 16:36:44 INFO - 'LANGUAGE': 'en_US:en', 16:36:44 INFO - 'LOGNAME': 'cltbld', 16:36:44 INFO - 'MAIL': '/var/mail/cltbld', 16:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:44 INFO - 'MOZ_NO_REMOTE': '1', 16:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:44 INFO - 'NO_EM_RESTART': '1', 16:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:44 INFO - 'PWD': '/builds/slave/test', 16:36:44 INFO - 'SHELL': '/bin/bash', 16:36:44 INFO - 'SHLVL': '1', 16:36:44 INFO - 'TERM': 'linux', 16:36:44 INFO - 'TMOUT': '86400', 16:36:44 INFO - 'USER': 'cltbld', 16:36:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:44 INFO - '_': '/tools/buildbot/bin/python'} 16:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:44 INFO - Running setup.py (path:/tmp/pip-X2wkZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:45 INFO - Running setup.py (path:/tmp/pip-rcpEae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:45 INFO - Running setup.py (path:/tmp/pip-kQyLNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:45 INFO - Running setup.py (path:/tmp/pip-m0v2b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:45 INFO - Running setup.py (path:/tmp/pip-jfOblT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:45 INFO - Running setup.py (path:/tmp/pip-nmdFMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:45 INFO - Running setup.py (path:/tmp/pip-GuU33c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:45 INFO - Running setup.py (path:/tmp/pip-x2fVUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:45 INFO - Running setup.py (path:/tmp/pip-KejPXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:45 INFO - Running setup.py (path:/tmp/pip-uyMrEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:45 INFO - Running setup.py (path:/tmp/pip-OHYEuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:45 INFO - Running setup.py (path:/tmp/pip-oSw35g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:45 INFO - Running setup.py (path:/tmp/pip-t1j43R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:45 INFO - Running setup.py (path:/tmp/pip-FhnAXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:45 INFO - Running setup.py (path:/tmp/pip-r0zvCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:46 INFO - Running setup.py (path:/tmp/pip-EMz4vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:46 INFO - Running setup.py (path:/tmp/pip-r4_DVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:46 INFO - Running setup.py install for manifestparser 16:36:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Running setup.py install for mozcrash 16:36:46 INFO - Running setup.py install for mozdebug 16:36:46 INFO - Running setup.py install for mozdevice 16:36:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Running setup.py install for mozfile 16:36:46 INFO - Running setup.py install for mozhttpd 16:36:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Running setup.py install for mozinfo 16:36:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Running setup.py install for mozInstall 16:36:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:46 INFO - Running setup.py install for mozleak 16:36:47 INFO - Running setup.py install for mozlog 16:36:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Running setup.py install for moznetwork 16:36:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Running setup.py install for mozprocess 16:36:47 INFO - Running setup.py install for mozprofile 16:36:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Running setup.py install for mozrunner 16:36:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Running setup.py install for mozscreenshot 16:36:47 INFO - Running setup.py install for moztest 16:36:47 INFO - Running setup.py install for mozversion 16:36:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:47 INFO - Cleaning up... 16:36:47 INFO - Return code: 0 16:36:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:47 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')]} 16:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:47 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')]} 16:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:47 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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:47 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 16:36:47 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 16:36:47 INFO - Using env: {'DISPLAY': ':0', 16:36:47 INFO - 'HOME': '/home/cltbld', 16:36:47 INFO - 'LANG': 'en_US.UTF-8', 16:36:47 INFO - 'LANGUAGE': 'en_US:en', 16:36:47 INFO - 'LOGNAME': 'cltbld', 16:36:47 INFO - 'MAIL': '/var/mail/cltbld', 16:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:47 INFO - 'MOZ_NO_REMOTE': '1', 16:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:47 INFO - 'NO_EM_RESTART': '1', 16:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:47 INFO - 'PWD': '/builds/slave/test', 16:36:47 INFO - 'SHELL': '/bin/bash', 16:36:47 INFO - 'SHLVL': '1', 16:36:47 INFO - 'TERM': 'linux', 16:36:47 INFO - 'TMOUT': '86400', 16:36:47 INFO - 'USER': 'cltbld', 16:36:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:47 INFO - '_': '/tools/buildbot/bin/python'} 16:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:48 INFO - Running setup.py (path:/tmp/pip-fRoSyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:48 INFO - Running setup.py (path:/tmp/pip-7gTCTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:48 INFO - Running setup.py (path:/tmp/pip-6tDRo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:48 INFO - Running setup.py (path:/tmp/pip-R3IM64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:48 INFO - Running setup.py (path:/tmp/pip-IhpCQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:48 INFO - Running setup.py (path:/tmp/pip-QF9wNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:48 INFO - Running setup.py (path:/tmp/pip-MMjIFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:48 INFO - Running setup.py (path:/tmp/pip-DtD8Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:48 INFO - Running setup.py (path:/tmp/pip-nI_hFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:48 INFO - Running setup.py (path:/tmp/pip-RPXlru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:48 INFO - Running setup.py (path:/tmp/pip-h9esoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:48 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)) 16:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:48 INFO - Running setup.py (path:/tmp/pip-NIHc43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:49 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)) 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:49 INFO - Running setup.py (path:/tmp/pip-G5i3sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:49 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)) 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:49 INFO - Running setup.py (path:/tmp/pip-NErYV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:49 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)) 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:49 INFO - Running setup.py (path:/tmp/pip-e1Qq6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:49 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)) 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:49 INFO - Running setup.py (path:/tmp/pip-r3KgYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:49 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)) 16:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:49 INFO - Running setup.py (path:/tmp/pip-MXrm2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:49 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)) 16:36:49 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)) 16:36:49 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)) 16:36:49 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)) 16:36:49 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)) 16:36:49 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)) 16:36:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:36:49 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 16:36:49 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 16:36:49 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 16:36:49 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 16:36:50 INFO - Downloading blessings-1.6.tar.gz 16:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:50 INFO - Installing collected packages: blessings 16:36:50 INFO - Running setup.py install for blessings 16:36:50 INFO - Successfully installed blessings 16:36:50 INFO - Cleaning up... 16:36:50 INFO - Return code: 0 16:36:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:50 INFO - Reading from file tmpfile_stdout 16:36:50 INFO - Current package versions: 16:36:50 INFO - argparse == 1.2.1 16:36:50 INFO - blessings == 1.6 16:36:50 INFO - blobuploader == 1.2.4 16:36:50 INFO - docopt == 0.6.1 16:36:50 INFO - functools32 == 3.2.3-2 16:36:50 INFO - jsonschema == 2.5.1 16:36:50 INFO - manifestparser == 1.1 16:36:50 INFO - mozInstall == 1.12 16:36:50 INFO - mozcrash == 1.0 16:36:50 INFO - mozdebug == 0.1 16:36:50 INFO - mozdevice == 0.51 16:36:50 INFO - mozfile == 1.2 16:36:50 INFO - mozhttpd == 0.7 16:36:50 INFO - mozinfo == 0.9 16:36:50 INFO - mozleak == 0.1 16:36:50 INFO - mozlog == 3.4 16:36:50 INFO - moznetwork == 0.27 16:36:50 INFO - mozprocess == 0.25 16:36:50 INFO - mozprofile == 0.28 16:36:50 INFO - mozrunner == 6.13 16:36:50 INFO - mozscreenshot == 0.1 16:36:50 INFO - mozsystemmonitor == 0.3 16:36:50 INFO - moztest == 0.8 16:36:50 INFO - mozversion == 1.4 16:36:50 INFO - psutil == 3.1.1 16:36:50 INFO - requests == 1.2.3 16:36:50 INFO - wsgiref == 0.1.2 16:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:50 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')]} 16:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:50 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')]} 16:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:50 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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:50 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 16:36:50 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 16:36:50 INFO - Using env: {'DISPLAY': ':0', 16:36:50 INFO - 'HOME': '/home/cltbld', 16:36:50 INFO - 'LANG': 'en_US.UTF-8', 16:36:50 INFO - 'LANGUAGE': 'en_US:en', 16:36:50 INFO - 'LOGNAME': 'cltbld', 16:36:50 INFO - 'MAIL': '/var/mail/cltbld', 16:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:50 INFO - 'MOZ_NO_REMOTE': '1', 16:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:50 INFO - 'NO_EM_RESTART': '1', 16:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:50 INFO - 'PWD': '/builds/slave/test', 16:36:50 INFO - 'SHELL': '/bin/bash', 16:36:50 INFO - 'SHLVL': '1', 16:36:50 INFO - 'TERM': 'linux', 16:36:50 INFO - 'TMOUT': '86400', 16:36:50 INFO - 'USER': 'cltbld', 16:36:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:50 INFO - '_': '/tools/buildbot/bin/python'} 16:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 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)) 16:36:51 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:36:51 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 16:36:51 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 16:36:51 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 16:36:51 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 16:36:52 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:36:52 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)) 16:36:52 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)) 16:36:52 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)) 16:36:52 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)) 16:36:52 INFO - Installing collected packages: marionette-driver 16:36:52 INFO - Running setup.py install for marionette-driver 16:36:52 INFO - Successfully installed marionette-driver 16:36:52 INFO - Cleaning up... 16:36:52 INFO - Return code: 0 16:36:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36:52 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')]} 16:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:52 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')]} 16:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:52 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 0xa6d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdeaef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, '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': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', '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 16:36:52 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 16:36:52 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 16:36:52 INFO - Using env: {'DISPLAY': ':0', 16:36:52 INFO - 'HOME': '/home/cltbld', 16:36:52 INFO - 'LANG': 'en_US.UTF-8', 16:36:52 INFO - 'LANGUAGE': 'en_US:en', 16:36:52 INFO - 'LOGNAME': 'cltbld', 16:36:52 INFO - 'MAIL': '/var/mail/cltbld', 16:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:52 INFO - 'MOZ_NO_REMOTE': '1', 16:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:52 INFO - 'NO_EM_RESTART': '1', 16:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:52 INFO - 'PWD': '/builds/slave/test', 16:36:52 INFO - 'SHELL': '/bin/bash', 16:36:52 INFO - 'SHLVL': '1', 16:36:52 INFO - 'TERM': 'linux', 16:36:52 INFO - 'TMOUT': '86400', 16:36:52 INFO - 'USER': 'cltbld', 16:36:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:52 INFO - '_': '/tools/buildbot/bin/python'} 16:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:36:52 INFO - Cleaning up... 16:36:52 INFO - Return code: 0 16:36:52 INFO - Running post-action listener: _resource_record_post_action 16:36:52 INFO - Running post-action listener: _start_resource_monitoring 16:36:52 INFO - Starting resource monitoring. 16:36:52 INFO - [mozharness: 2017-05-28 23:36:52.754248Z] Finished create-virtualenv step (success) 16:36:52 INFO - [mozharness: 2017-05-28 23:36:52.754775Z] Running install step. 16:36:52 INFO - Running pre-action listener: _resource_record_pre_action 16:36:52 INFO - Running main action method: install 16:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:52 INFO - Reading from file tmpfile_stdout 16:36:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:53 INFO - Reading from file tmpfile_stdout 16:36:53 INFO - Output received: 16:36:53 INFO - Usage: mozinstall [options] installer 16:36:53 INFO - Options: 16:36:53 INFO - -h, --help show this help message and exit 16:36:53 INFO - -d DEST, --destination=DEST 16:36:53 INFO - Directory to install application into. [default: 16:36:53 INFO - "/builds/slave/test"] 16:36:53 INFO - --app=APP Application being installed. [default: firefox] 16:36:53 INFO - mkdir: /builds/slave/test/build/application 16:36:53 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'] 16:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:37:08 INFO - Reading from file tmpfile_stdout 16:37:08 INFO - Output received: 16:37:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:37:08 INFO - Running post-action listener: _resource_record_post_action 16:37:08 INFO - [mozharness: 2017-05-28 23:37:08.597668Z] Finished install step (success) 16:37:08 INFO - [mozharness: 2017-05-28 23:37:08.597941Z] Running setup-mitmproxy step. 16:37:08 INFO - Running pre-action listener: _resource_record_pre_action 16:37:08 INFO - Running main action method: setup_mitmproxy 16:37:08 INFO - Skipping: mitmproxy is not required 16:37:08 INFO - Running post-action listener: _resource_record_post_action 16:37:08 INFO - [mozharness: 2017-05-28 23:37:08.599044Z] Finished setup-mitmproxy step (success) 16:37:08 INFO - [mozharness: 2017-05-28 23:37:08.599260Z] Running run-tests step. 16:37:08 INFO - Running pre-action listener: _resource_record_pre_action 16:37:08 INFO - Running main action method: run_tests 16:37:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:37:08 INFO - Python 2.7.3 16:37:08 INFO - Return code: 0 16:37:08 INFO - grabbing minidump binary from tooltool 16:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:37:08 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 0xde7e40>, '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 0xde8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xde9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:37:08 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 16:37:08 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 16:37:08 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 16:37:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:08 INFO - Return code: 0 16:37:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:37:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:37:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:37:08 INFO - ENV: RUST_BACKTRACE is now 1 16:37:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:37:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:37:08 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/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:37:08 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/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 16:37:08 INFO - Using env: {'DISPLAY': ':0', 16:37:08 INFO - 'HOME': '/home/cltbld', 16:37:08 INFO - 'LANG': 'en_US.UTF-8', 16:37:08 INFO - 'LANGUAGE': 'en_US:en', 16:37:08 INFO - 'LOGNAME': 'cltbld', 16:37:08 INFO - 'MAIL': '/var/mail/cltbld', 16:37:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:37:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:08 INFO - 'MOZ_NO_REMOTE': '1', 16:37:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:08 INFO - 'NO_EM_RESTART': '1', 16:37:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:08 INFO - 'PWD': '/builds/slave/test', 16:37:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:37:08 INFO - 'RUST_BACKTRACE': '1', 16:37:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:37:08 INFO - 'SHELL': '/bin/bash', 16:37:08 INFO - 'SHLVL': '1', 16:37:08 INFO - 'TERM': 'linux', 16:37:08 INFO - 'TMOUT': '86400', 16:37:08 INFO - 'USER': 'cltbld', 16:37:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236', 16:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:08 INFO - '_': '/tools/buildbot/bin/python'} 16:37:08 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/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:37:08 INFO - mozversion application_buildid: 20170528225122 16:37:08 INFO - mozversion application_changeset: 4541134e973a6bd5e667a603e844854c8e5361da 16:37:08 INFO - mozversion application_display_name: Nightly 16:37:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:08 INFO - mozversion application_name: Firefox 16:37:08 INFO - mozversion application_remotingname: firefox 16:37:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:37:08 INFO - mozversion application_vendor: Mozilla 16:37:08 INFO - mozversion application_version: 55.0a1 16:37:08 INFO - mozversion platform_buildid: 20170528225122 16:37:08 INFO - mozversion platform_changeset: 4541134e973a6bd5e667a603e844854c8e5361da 16:37:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:37:08 INFO - mozversion platform_version: 55.0a1 16:37:08 INFO - using testdate: 1496014628 16:37:08 INFO - actual date: 1496014628 16:37:08 INFO - starting webserver on 'localhost:60078' 16:37:08 INFO - SUITE-START | Running 2 tests 16:37:08 INFO - TEST-START | dromaeo_css 16:37:08 INFO - operating with platform_type : linux_ 16:37:08 INFO - Initialising browser for dromaeo_css test... 16:37:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html -profile /tmp/tmpMWjnYb/profile 16:37:08 INFO - TEST-INFO | started process 18122 (/builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html) 16:37:44 INFO - TEST-INFO | 18122: killed by SIGTERM 16:37:44 INFO - Browser initialized. 16:37:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:37:44 INFO - TEST-INFO | started process 18319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMWjnYb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:37:56 INFO - PID 18319 | RSS: Main: 183181312 16:37:56 INFO - PID 18319 | 16:41:02 INFO - PID 18319 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60078/tests/dromaeo/cssquery-ext.html) 16:41:03 INFO - PID 18319 | RSS: Main: 178712576 16:41:03 INFO - PID 18319 | 16:44:05 INFO - PID 18319 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-ext.html (next: http://localhost:60078/tests/dromaeo/cssquery-jquery.html) 16:44:06 INFO - PID 18319 | RSS: Main: 184741888 16:44:06 INFO - PID 18319 | 16:47:08 INFO - PID 18319 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60078/tests/dromaeo/cssquery-mootools.html) 16:47:08 INFO - PID 18319 | RSS: Main: 181477376 16:47:08 INFO - PID 18319 | 16:50:10 INFO - PID 18319 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60078/tests/dromaeo/cssquery-prototype.html) 16:50:11 INFO - PID 18319 | RSS: Main: 185454592 16:50:11 INFO - PID 18319 | 16:53:14 INFO - PID 18319 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60078/tests/dromaeo/cssquery-yui.html) 16:53:14 INFO - PID 18319 | RSS: Main: 184442880 16:53:14 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | Cycle 1(1): loaded http://localhost:60078/tests/dromaeo/cssquery-yui.html (next: http://localhost:60078/tests/dromaeo/cssquery-dojo.html) 16:56:16 INFO - PID 18319 | RSS: Main: 182042624 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | __start_tp_report 16:56:16 INFO - PID 18319 | _x_x_mozilla_page_load 16:56:16 INFO - PID 18319 | _x_x_mozilla_page_load_details 16:56:16 INFO - PID 18319 | |i|pagename|runs| 16:56:16 INFO - PID 18319 | |0;dojo.html;2752.1055656911503;2752.7109653486395;2777.3334399744067;2792.7905407094468;2792.804503684743;5169.844904652857;5245.86885327866;5288.259643649887;5303.992241474122;5350.151805688715;5290.470952904708;5298.788048478066;5307.73461326934;5344.652597581155;5406.02691515527;4618.261078227484;4706.058788242357;4753.382060332152;4757.048590281957;4803.495632958541;4772.117158325704;4801.039792041588;4827;4828.082664293773;4841.7337046462435;4676.579107880307;4686.601638860701;4704.01215744694;4771.475137734847;4796.856094317176;4745.810167593292;4757.809687612491;4776.832810851603;4787.54518320759;4797.160496913061;4696.131215725068;4700.482946875841;4719.126961512131;4720.291956206562;4720.33915251865;5191.0656081905245;5271.130263506517;5288.603354748371;5293.153095504739;5314.707691077027;5699.658020518741;5726.513246374063;5741.224934633813;5819.6508209507565;5826.854328641775;5840.153177789197;5840.766369345221;5850.736716847752;5858.648481091148;5909.704514774244;5370.946290537123;5387.649802762886;5399.892002159935;5404.378496472956;5406.83779486616;5749.88500229993;5858.7070646468355;5919.6152250103605;5932.110183472513;5965.28416590012;5668.489835914787;5675.517581005578;5695;5709.457601527848;5724.942750572524;5654.886902261932;5771.047777116729;5778.075507918713;5778.624389414675;5782.421757824184;5610.803621873215;5693.259876216148;5732.111522713986;5739.397363276796;5742.339630942495;5673.262475878109;5676.489115979582;5716.799912003143;5765.509931655773;5766.106253530709;4746.098241334135;4749.4775574686755;4776.188048031843;4784.234522476457;4800.991791723707;4074.572169922175;4077.612626800449;4081.5714349992822;4081.795910204478;4121.814518346621;4742.359781429532;4760.642951778561;4809.326694262806;4855.448665200426;4891.119598472309;5799.159121927297;5811.27359080115;5824.126381042877;5842.912356314659;5854.063349864001;4801.855944321676;4803.1114243864995;4806.086843499794;4806.44725856524;4851.126797176472;4969.850904472727;5027.572656324181;5028.7737051832755;5034.672746271481;5068.797248110108;5297.894042119213;5303.893922121613;5341.359036915595;5355.651882627617;5370.436104209158;5624.128260119688;5731.770729170787;5732.71336433185;5769.59612827098;5784.421557844182;5292.232626269092;5337.733113344239;5346.866328341823;5387.434319396407;5389.110796718497;5677.176809362537;5683.943160568341;5689.402612725604;5697.116946873241;5699.145128230799;5665.801696940587;5741.712914354349;5746.741396637078;5799.246098007232;5822.3304320003745;5610.074337734228;5632.901584191207;5651.067573850433;5655.604107712586;5678.77284908599;5577.330720313588;5592.86017849557;5600.271964644733;5610.607257491936;5614.101743720985;5394.595405344537;5525.143602741581;5544.972275138599;5553.6390134641115;5554.888902222014;5556.777728890799;5571.916421253765;5603.719814009365;5616.578756593353;5627.493525582717;5483.479069488392;5488.807891723771;5502.119660854244;5502.614816962774;5526.005319042611 16:56:16 INFO - PID 18319 | |1;ext.html;644.7678835619176;717.4941666125383;728.9744858929938;1080.4057768227478;1093.573506332531;33324.833375833114;34517.82741086294;34591;34639.48040779384;34697;35229;35717.46423803645;35782.8210858946;35794.64205357945;35809;6689.8662026759675;6888;6982.2319544850025;7128.85742285154;7132.609141217465;6853.897191542131;6894.793156205297;6915.1701795784575;6927.7228910843505;6956.513044086916;6899.413549848269;6908.861822763567;6945.166580010406;6946.444284457231;6960.617166055865;6898.965505172467;6906.309369063104;6922.480813938924;6925.3074692530345;6944.72221111155;6770.695318710621;6793.626350550718;6794.3545363190915;6826;6829.180498340182;31815.522767158513;32026;32032.519512207335;32137.196570085936;32187;3071.262896904749;3107.6115485564305;3107.7047680470546;3109.657937626859;3112.3464072544566;25209.747902520925;25268.494630107478;25313.746862531323;25376;25395.61906571403;3004.8647810848565;3019.8037127586636;3048.9390212195854;3051;3058.357744873579;117173;118295.99999999914;135055;136496;136672.31663841716;40004;40526.79736601298;40644.593554064675;40656.59343406587;40718;41960.58039419628;42134.57865421368;42148.57851421508;42170.36744448836;42179.36730949038;12335.6916077097;12604.558840440724;12623.368831558386;12637.368131593383;12670.873291267153;10132.797344053226;10159.288849780445;10172.949135254275;10203.081722644998;10274.794504109876;13129.67175820593;13145.474181032843;13145.67135821593;13169.209847409185;13202.801957970638;5424.430434804289;5478;5513.393526712059;5521.282233309725;5539.833804985857;851.3146916731966;894.7271082319825;904.742148487691;911.7674992876906;926.282131348197;20780.480487987923;20967.895160524404;25713;26812.195634131007;27060.1881943542;958.4441024205944;962.821877952567;982.2044144243185;984.5028260728286;987.0918754745651;11288;11474;11740.765184696429;11758.941205293919;11805.822912656316;173848;176166;176453;176628;176865;41374.58625413707;41643.7917810409;41762.373564396556;41924.790376048535;41987.1602567953;1185.5968970550055;1212.5695378140808;1223.9143259971895;1227.4476485581702;1235.197121870791;20017.59964800725;20558.691619626017;21014;21151.788482114982;21463.678044829026;30644.540331895485;31100.533491998092;32092.83953580217;32706.182345441553;37246.44130337993;136628;137993.3100334492;138639;138768;139016;28881.42237155203;29371.11886643404;29665.5550166752;29694.109176724734;29707.702922970493;35623.465648015816;36298.27403451969;36380.63619363772;36657.816710916275;36852.447213292355;27183.86408067947;27377.726222737518;27437.725622744314;27682.86158569275;28960.85519572473;26958.595621065306;27478.313042174104;27751.722482774912;27778;29084.418311633224;29787.404251914406;30123.246918827204;30271.243218919702;30744;31187.064388068393;27041.72958270471;27170.32074198161;28521.42957140887;28610.713892860804;28885.711142888304;19926;22742.20402285912;22784.063354615042;22983.77016229883;23053.19313824008 16:56:16 INFO - PID 18319 | |2;jquery.html;422.36223302812743;424.09067970963855;428.5757100470533;443.8313440892461;450.84671211787963;17152.142392880352;17842.821571784294;17949.19228634711;18205.7269140963;18676.719849202273;18712.345067922626;18782.154803033864;18829;18847.434576962714;18982.810171898313;5277.102892508264;5288.762005709743;5427.348718153827;5504.752286147113;5505.752241149138;5290.312259406272;5355.625106242545;5387.19192121181;5403.756830942597;5415.079436495786;5175.146100893348;5307;5320.9467905321035;5322.787088516455;5325.360956685203;5288.312519372476;5360.59795515334;5396.568274538027;5405.297311349519;5408.296921400232;4647.976760116211;4870.293807397943;4875.171220892456;4877.829275975359;4884.926726099111;21502.892485537628;21982.560348792933;22069.558608827734;22136;22178.338599368017;1564.9217539123113;1588.285271627772;1594.4180374163464;1595.3459081776416;1615.3861532617648;14339.713205735827;14631.195284259362;14716;14759.557213283619;15070.849291507055;2048.078364735875;2090.1325949730995;2102.8317734581196;2135.177956486764;2157.8273738100916;74788;85173;87675.56162219212;88361.11638883593;90702.5464872678;10734.409607471507;10947.397893115955;11175;11186.272892261977;11204.551817927355;15861.841381586268;15898.76151857723;15906.681866362607;15911.124888131033;15924.363025479082;7097.964510177416;7267.382272506896;7319.780406587811;7383.483156179016;7387.409007279405;6318.936810631927;6382.808515744535;6530.869382612416;6576.5067619928695;6578;7043.9647801761685;7078.539894906815;7117.572945623279;7186.173590037108;7205.7838264852135;2076.512019675375;2093.654546999728;2131.083634037379;2147.516808718026;2247.224707475918;829.9004119505698;853.1127627267696;884.1909652667865;888.391451855481;891.7503099132254;17087.401940932257;17151;17189.04651930063;17731.645367092842;17932.55168620795;859.7893516088599;865.446114486729;870.4646642314931;877.241186373782;894.2935081285711;9144.588493517807;9429.764255893657;9706.077922597342;9755;9882.851757223647;355837;358153;361041.70103840093;363051;366854;73600.63199683967;74054;74854.25145748582;75024;75066;1029.2126523209752;1039.9480025998669;1048.6644273832453;1051.2115913065202;1059.8622179116664;14505.78241326402;14747.115173089649;14786.334614942569;14891.25543722788;15325.927185096936;37182.256354873294;37568.43647345347;38010.61989380181;38377.61622383852;39009.80495097506;45486;46565.53434465612;46786.29820552626;47133.7643311795;48006.519934800206;8101.797455063671;8106.270435660819;8107.554084525408;8260.793480163044;8446.070932197576;12414.379281035732;12924.870751292367;13130.146540474838;13233.735325293634;13262.336883155996;10329.12202462799;10598.25812193139;10815.945920270347;11137.71437425945;11230.708468526223;10569.894301056891;10666.146708263475;10809.56761729522;10889.292196007234;10911.290766100177;10878.836817447904;11011.72470688207;11122;11168.720781980515;11557.768844622893;8284.295834853863;8442.451240669337;8474.830503389774;8602.440841345542;8616.396852220285;10381.584736610452;10771.407572583583;11103.50034248477;11156.10751139923;11270.380129092979 16:56:16 INFO - PID 18319 | |3;mootools.html;1235.9876401235986;1294.5210272199288;1297.156848048768;1298.0589072922132;1299.746549422863;10319.43243121628;10782.353058816476;10899.83650245246;10923.235373523856;11131.165162612817;10897;11093.667189984293;11100.777984440327;11113.83329250062;11129.109671226302;2118.883461409618;2174.8151407130413;2176.4014895903597;2182.378022263655;2186.1255497800926;2146.7853214678485;2188.102877820094;2189.748178959424;2196.9780302197014;2203.394066631673;2101.8003289687454;2110.0610228448345;2123.087072558807;2123.893805309736;2126.797954194349;2079.334612923865;2085.9687104693444;2089.2896415218747;2098.653722135846;2100.6953991671276;1852.8888266704041;1927.9710804337806;2064.865783724053;2097.7272954515815;2111.144986280559;10522.053015228666;10576.788464230749;10578.576856925714;10583.947080264626;10590.09984151348;5559.277293951801;5758.107493338539;5759.539236861041;5763.1355296705415;5770.394108618577;3371.1740623547144;3499.6675315844955;3575.803330816804;3580.7493475456727;3596.6762991330907;1122.7586068995206;1142.731458107344;1155.7110722319421;1166.2186335155382;1171.94140292985;15714;15881.126538040404;15889.602759930978;16003.51989440307;16011.359545618161;4640.118377508263;4779.593734532534;4895.437024742129;4902.117618828645;4902.975485122552;11346.262492937933;11353.772924541629;11366.261193022427;11388.829167562493;11410.771784564262;5488.807891723771;5713.05734553794;5713.942860571341;5726.3700992890745;5732.971335143381;5173.094708426011;5253.605979551549;5267;5285.894282114336;5311.044012077863;3908.804559772;3976.463177471004;4001.1197536541913;4059.3505039193587;4064.4106604542767;1171.3323405658693;1191.3566673996118;1192.3203773848995;1194.6834088966432;1207.3540655749132;663.8174502011985;686.9381755642016;689.3864460630043;707.4163814852767;712.2770388056127;5363.141897296414;5452.318460192476;5498.395176530578;5624.606277560613;5638.2670252866865;541.5856869494839;544.064209559557;549.8680316723958;550.9641873278224;552.0890530624501;3395.2700169463683;3405.1997780521556;3510.7191424685966;3520.331137083946;3732.402815549499;13656;14154.363053662404;14283.857161428461;14342.49801256951;14396.784048239284;13548.45806167762;14313.212773297568;14326.856731432761;14328.641783955276;14331.78502322466;7020.5787652741;7161.713531458891;7246.058012458347;7263.273672632695;7291.562506249642;5674.347450043298;5811.651300921958;5824.009918313982;5844.883102338014;6061.1514387984835;12373.876261237272;12440.564580239648;12484.188527745668;12508.874911251136;12632.621021369374;12322.075844311892;12772.744545109232;12805.103642744918;12997.350132493526;13007.284599347127;8417.368697347601;8450.366222533212;8500.319974402157;8519.446235994641;8582.78543036429;9847.359921605073;9870.407775533491;9961.50192490387;9965.302428829913;9995.350302230332;8340.207680270365;8426.283765879969;8497.957510212409;8622.094680058504;8709.608067636846;8371.455855369382;8413.747587572383;8448.83102337962;8537.274331681876;8788.780280492783;6930.61881596517;7077.186123595852;7082.716691332289;7092.255313192247;7102.289771023063;4895.7062576245535;5457.481539253765;5483.616146869681;5587.217789509391;5702.657840529581;5293.206019097166;5333.813316533902;5362.973185134206;5390.27231323782;5405.5135037846785 16:56:16 INFO - PID 18319 | |4;prototype.html;378.69136653627294;388.3126865448157;400.1556715330652;400.20359484625595;401.24966312994707;5387.164989426636;5489.396166421696;5514.80698175564;5536.363318218406;5544.08935308963;5319.946800531993;5403.162509810985;5411.269478620385;5412.2422860799425;5413.972930135354;4135.214309281227;4141.606547378002;4166.208420400114;4169.937450938239;4175.31107367284;4099.544661645118;4155.792210389468;4174.686898482611;4174.958250417502;4191.476065491814;4130.834766609332;4137.420761093449;4138.627523522882;4140.254754144253;4162.209180255757;4110.527289361702;4111.075008123148;4111.732737372061;4114.053767633446;4115.156392939441;3545.3795585772386;3621.7826930384263;3629.981850090759;3634.745567810254;3638.7089032877307;5274.918641678447;5289.365276166846;5301.443348448396;5337.5196232338885;5370.140777475585;4870.537298956593;4894.119058569456;4894.926576101361;4903.8774030649165;4907.730074845882;5595.300587426572;5669.291338582677;5726.711489914777;5755.597108202427;5769.480746732772;4080.10237747695;4084.6936479764136;4087.570805065485;4106.917861642781;4112.8149233284275;5753.280839895013;5853.326867410302;5961.314448838396;6046.455818976313;6139.969300153515;4088.284550203762;4096.221717873595;4117.691173161965;4126.834926602903;4135.152293779768;4172.749635021848;4187.183499217685;4197.543193847985;4201.243776120266;4203.642690371292;4726.1020406122725;4761.166795810719;4791.676037121993;4811.927821082687;4817;5751.22358481608;5764.308283006066;5769.365369809318;5769.8557536061935;5777;1449.9420023198954;1459.547540262522;1459.9051061680957;1462.3200211901517;1465.7215129125432;950.1955027246782;967.2842096848423;1000.51975051974;1003.5534187286587;1003.7390278527636;4926.5073492650445;4939.703617782944;4942.827001054946;4945.9258111128365;4950.9009819803405;5904.106987576057;5935.52515798735;5958.582899197015;5973.701314934236;5979.833932383231;4795.736234507066;4896.853094407174;4902.338184345139;4914.533119353656;4940.407151141814;3124.453220686371;3146.3392687535875;3146.5437511560694;3147.7009684079976;3166.493361062219;5427.348718153847;5498.120300751861;5518.806841760519;5521.696306703089;5525.392206857243;6044.576879618385;6103.95517501633;6109.450149486567;6144.754209831557;6151.7539298428455;5508.779648814003;5515.806946756844;5518;5519.420460851553;5521.806736764194;5877.353491115889;5889.94110058894;5916.526677865846;5919.921640746701;5944.970275148597;5827.038538641246;5840.54697027258;5848.795292164924;5858.502027327554;5859.267591551056;5272.841814745564;5316.202569614588;5426.511613954763;5479.287692599936;5492.91760623583;4186.979065104655;4192.981053641373;4199.349100889367;4199.853005144805;4199.916001680011;5791.971040144772;5967.194428752063;5993.640381577119;6013.158157857816;6026.517878569792;5778.133280008033;5807.216025836458;5832.737526811219;5835.56233282497;5839.5036421904615;5585.106382978704;5771.913421298768;5809.360970293349;5836.649801011953;5837.445442682938;5696.401877802937;5720.141978703228;5724.685142317213;5727.336788393417;5764.2043608848835;5707.543396528351;5815.8255252340805;5831.504322132666;5848.678322692293;5860.619059761102;5639.746211420414;5653.858653533694;5677.403872593318;5684.118961560965;5691.292612216236 16:56:16 INFO - PID 18319 | |5;yui.html;693.2686016252851;713.3187805645609;743.4275607782007;750.9899185595376;767.3094215206314;12765.872341276585;13089.083764136514;13977.650558736037;14894.925525372371;14920.030198037133;15399.461018864342;16054.75917861233;16071.919640401811;16127.274272657729;16134.515964521082;886.844802159621;909.2316992141663;916.6104405627582;917.6283605139896;919.6781126605702;907.3059109781022;911.6171208092617;912.4297314178639;912.8813254276935;917.6467060181844;920.6501529418812;952.5618215620823;952.6141912525403;953.2183609440261;954.9331546791727;941.6657086734214;948.6821914658598;951.4148798488949;952.552300418802;955.0544960489066;690.9481788865855;691.934266244711;695.1345574759457;695.7564852301705;697.010245451455;15170;15330.463433779876;15419.845801542066;15493;15515.45695900638;16279.430219942245;16575.91712041444;16692.415765448273;16704.164791760362;16735.246913888903;12390.380480976006;13008.34958252093;13236.470541178342;13250.602481925558;13300.80048799259;3104.5653608494827;3107.7669174811754;3127.0618814355603;3128.264857758425;3137.0118412700153;74014.25985740128;86983;88656.55671721665;89933.10066899312;90889;12923.22460652364;13150.079494435298;13302.733945321039;13344.599662010156;13364;23786.405339866295;24507;24527.386815329402;24627.261182164562;24629.137980170966;6407;6599.406053455212;6646.4350530205475;6668.099806526154;6693.196816382066;3079.2455848317304;3117.7505799535984;3135.0908236611585;3142.6857314268846;3147.244661281276;3678.503402040744;3767.9246415072093;3771.07608635886;3771.245750849841;3776.678982286536;794.9483283586549;822.0874828939872;823.168599714281;827.123249355685;834.4117397235057;603.4900509069829;610.9755609775559;611.1901730207404;613.6287546034584;631.1321932343028;9814.803703926023;10391.324563903323;10555.525001374957;11329.320240785579;11633.767324653629;621.0963048764038;629.8173529676343;630.2437075509407;631.182618509032;638.4796390941368;4894.632902532324;4999.125153098194;5066.404082713933;5077.314562534085;5226.268322434862;90618;90928;91283;93117.5344123275;93722.53138734262;78909.21090789018;79678;79755.60122199352;80373.19626803775;80893;59511;64535.67732161309;64988.35011649823;65430;66034.66982665056;9654.469004204837;10690.893091069302;10772.946135269587;10778.514966826355;10788.838167427652;27277.181684549494;27560.17319480419;28020.719792802625;28589;28738.13785586436;33686.83156584201;49674;50773.49226507688;51270;51342.74328628333;14602.97779155449;14640.414383424544;15016.774748378564;15020.399184032953;15384.923075384999;16922.915385422995;16980.660386792442;17043.659126817147;17224.483265502055;17383.47849564515;14457.855421446071;14520.201388923288;15000.024998375071;15693.686126277182;15795.921020394824;15169.848301517284;15334;15382.615434614225;15521.68956620884;15712.057276563442;14753.55739327779;14814.25928703539;14999.625009374417;15221.695566088838;15408.460703875311;9793.461359625004;9892.604295828374;9973.451460169761;10166.491675416348;10322.587096516056;11746.177767556532;12348.691282718004;12539.49842006346;12578.371081445708;12625.116241862981 16:56:16 INFO - PID 18319 | __end_tp_report 16:56:16 INFO - PID 18319 | __start_cc_report 16:56:16 INFO - PID 18319 | _x_x_mozilla_cycle_collect,381 16:56:16 INFO - PID 18319 | __end_cc_report 16:56:16 INFO - PID 18319 | __startTimestamp1496015776623__endTimestamp 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | ------- Summary: start ------- 16:56:16 INFO - PID 18319 | Number of tests: 6 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | [#0] dojo.html Cycles:165 Average:5249.14 Median:5399.89 stddev:628.37 (11.6%) stddev-sans-first:598.98 16:56:16 INFO - PID 18319 | Values: 2752.1 2752.7 2777.3 2792.8 2792.8 5169.8 5245.9 5288.3 5304.0 5350.2 5290.5 5298.8 5307.7 5344.7 5406.0 4618.3 4706.1 4753.4 4757.0 4803.5 4772.1 4801.0 4827.0 4828.1 4841.7 4676.6 4686.6 4704.0 4771.5 4796.9 4745.8 4757.8 4776.8 4787.5 4797.2 4696.1 4700.5 4719.1 4720.3 4720.3 5191.1 5271.1 5288.6 5293.2 5314.7 5699.7 5726.5 5741.2 5819.7 5826.9 5840.2 5840.8 5850.7 5858.6 5909.7 5370.9 5387.6 5399.9 5404.4 5406.8 5749.9 5858.7 5919.6 5932.1 5965.3 5668.5 5675.5 5695.0 5709.5 5724.9 5654.9 5771.0 5778.1 5778.6 5782.4 5610.8 5693.3 5732.1 5739.4 5742.3 5673.3 5676.5 5716.8 5765.5 5766.1 4746.1 4749.5 4776.2 4784.2 4801.0 4074.6 4077.6 4081.6 4081.8 4121.8 4742.4 4760.6 4809.3 4855.4 4891.1 5799.2 5811.3 5824.1 5842.9 5854.1 4801.9 4803.1 4806.1 4806.4 4851.1 4969.9 5027.6 5028.8 5034.7 5068.8 5297.9 5303.9 5341.4 5355.7 5370.4 5624.1 5731.8 5732.7 5769.6 5784.4 5292.2 5337.7 5346.9 5387.4 5389.1 5677.2 5683.9 5689.4 5697.1 5699.1 5665.8 5741.7 5746.7 5799.2 5822.3 5610.1 5632.9 5651.1 5655.6 5678.8 5577.3 5592.9 5600.3 5610.6 5614.1 5394.6 5525.1 5545.0 5553.6 5554.9 5556.8 5571.9 5603.7 5616.6 5627.5 5483.5 5488.8 5502.1 5502.6 5526.0 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | [#1] ext.html Cycles:180 Average:29786.59 Median:16857.90 stddev:38471.14 (228.2%) stddev-sans-first:38516.83 16:56:16 INFO - PID 18319 | Values: 644.8 717.5 729.0 1080.4 1093.6 33324.8 34517.8 34591.0 34639.5 34697.0 35229.0 35717.5 35782.8 35794.6 35809.0 6689.9 6888.0 6982.2 7128.9 7132.6 6853.9 6894.8 6915.2 6927.7 6956.5 6899.4 6908.9 6945.2 6946.4 6960.6 6899.0 6906.3 6922.5 6925.3 6944.7 6770.7 6793.6 6794.4 6826.0 6829.2 31815.5 32026.0 32032.5 32137.2 32187.0 3071.3 3107.6 3107.7 3109.7 3112.3 25209.7 25268.5 25313.7 25376.0 25395.6 3004.9 3019.8 3048.9 3051.0 3058.4 117173.0 118296.0 135055.0 136496.0 136672.3 40004.0 40526.8 40644.6 40656.6 40718.0 41960.6 42134.6 42148.6 42170.4 42179.4 12335.7 12604.6 12623.4 12637.4 12670.9 10132.8 10159.3 10172.9 10203.1 10274.8 13129.7 13145.5 13145.7 13169.2 13202.8 5424.4 5478.0 5513.4 5521.3 5539.8 851.3 894.7 904.7 911.8 926.3 20780.5 20967.9 25713.0 26812.2 27060.2 958.4 962.8 982.2 984.5 987.1 11288.0 11474.0 11740.8 11758.9 11805.8 173848.0 176166.0 176453.0 176628.0 176865.0 41374.6 41643.8 41762.4 41924.8 41987.2 1185.6 1212.6 1223.9 1227.4 1235.2 20017.6 20558.7 21014.0 21151.8 21463.7 30644.5 31100.5 32092.8 32706.2 37246.4 136628.0 137993.3 138639.0 138768.0 139016.0 28881.4 29371.1 29665.6 29694.1 29707.7 35623.5 36298.3 36380.6 36657.8 36852.4 27183.9 27377.7 27437.7 27682.9 28960.9 26958.6 27478.3 27751.7 27778.0 29084.4 29787.4 30123.2 30271.2 30744.0 31187.1 27041.7 27170.3 28521.4 28610.7 28885.7 19926.0 22742.2 22784.1 22983.8 23053.2 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | [#2] jquery.html Cycles:180 Average:24375.74 Median:37375.35 stddev:60002.91 (160.5%) stddev-sans-first:60144.28 16:56:16 INFO - PID 18319 | Values: 422.4 424.1 428.6 443.8 450.8 17152.1 17842.8 17949.2 18205.7 18676.7 18712.3 18782.2 18829.0 18847.4 18982.8 5277.1 5288.8 5427.3 5504.8 5505.8 5290.3 5355.6 5387.2 5403.8 5415.1 5175.1 5307.0 5320.9 5322.8 5325.4 5288.3 5360.6 5396.6 5405.3 5408.3 4648.0 4870.3 4875.2 4877.8 4884.9 21502.9 21982.6 22069.6 22136.0 22178.3 1564.9 1588.3 1594.4 1595.3 1615.4 14339.7 14631.2 14716.0 14759.6 15070.8 2048.1 2090.1 2102.8 2135.2 2157.8 74788.0 85173.0 87675.6 88361.1 90702.5 10734.4 10947.4 11175.0 11186.3 11204.6 15861.8 15898.8 15906.7 15911.1 15924.4 7098.0 7267.4 7319.8 7383.5 7387.4 6318.9 6382.8 6530.9 6576.5 6578.0 7044.0 7078.5 7117.6 7186.2 7205.8 2076.5 2093.7 2131.1 2147.5 2247.2 829.9 853.1 884.2 888.4 891.8 17087.4 17151.0 17189.0 17731.6 17932.6 859.8 865.4 870.5 877.2 894.3 9144.6 9429.8 9706.1 9755.0 9882.9 355837.0 358153.0 361041.7 363051.0 366854.0 73600.6 74054.0 74854.3 75024.0 75066.0 1029.2 1039.9 1048.7 1051.2 1059.9 14505.8 14747.1 14786.3 14891.3 15325.9 37182.3 37568.4 38010.6 38377.6 39009.8 45486.0 46565.5 46786.3 47133.8 48006.5 8101.8 8106.3 8107.6 8260.8 8446.1 12414.4 12924.9 13130.1 13233.7 13262.3 10329.1 10598.3 10815.9 11137.7 11230.7 10569.9 10666.1 10809.6 10889.3 10911.3 10878.8 11011.7 11122.0 11168.7 11557.8 8284.3 8442.5 8474.8 8602.4 8616.4 10381.6 10771.4 11103.5 11156.1 11270.4 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | [#3] mootools.html Cycles:180 Average:6475.93 Median:3548.07 stddev:4323.07 (121.8%) stddev-sans-first:4317.27 16:56:16 INFO - PID 18319 | Values: 1236.0 1294.5 1297.2 1298.1 1299.7 10319.4 10782.4 10899.8 10923.2 11131.2 10897.0 11093.7 11100.8 11113.8 11129.1 2118.9 2174.8 2176.4 2182.4 2186.1 2146.8 2188.1 2189.7 2197.0 2203.4 2101.8 2110.1 2123.1 2123.9 2126.8 2079.3 2086.0 2089.3 2098.7 2100.7 1852.9 1928.0 2064.9 2097.7 2111.1 10522.1 10576.8 10578.6 10583.9 10590.1 5559.3 5758.1 5759.5 5763.1 5770.4 3371.2 3499.7 3575.8 3580.7 3596.7 1122.8 1142.7 1155.7 1166.2 1171.9 15714.0 15881.1 15889.6 16003.5 16011.4 4640.1 4779.6 4895.4 4902.1 4903.0 11346.3 11353.8 11366.3 11388.8 11410.8 5488.8 5713.1 5713.9 5726.4 5733.0 5173.1 5253.6 5267.0 5285.9 5311.0 3908.8 3976.5 4001.1 4059.4 4064.4 1171.3 1191.4 1192.3 1194.7 1207.4 663.8 686.9 689.4 707.4 712.3 5363.1 5452.3 5498.4 5624.6 5638.3 541.6 544.1 549.9 551.0 552.1 3395.3 3405.2 3510.7 3520.3 3732.4 13656.0 14154.4 14283.9 14342.5 14396.8 13548.5 14313.2 14326.9 14328.6 14331.8 7020.6 7161.7 7246.1 7263.3 7291.6 5674.3 5811.7 5824.0 5844.9 6061.2 12373.9 12440.6 12484.2 12508.9 12632.6 12322.1 12772.7 12805.1 12997.4 13007.3 8417.4 8450.4 8500.3 8519.4 8582.8 9847.4 9870.4 9961.5 9965.3 9995.4 8340.2 8426.3 8498.0 8622.1 8709.6 8371.5 8413.7 8448.8 8537.3 8788.8 6930.6 7077.2 7082.7 7092.3 7102.3 4895.7 5457.5 5483.6 5587.2 5702.7 5293.2 5333.8 5363.0 5390.3 5405.5 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | [#4] prototype.html Cycles:180 Average:4746.62 Median:5378.65 stddev:1393.95 (25.9%) stddev-sans-first:1358.76 16:56:16 INFO - PID 18319 | Values: 378.7 388.3 400.2 400.2 401.2 5387.2 5489.4 5514.8 5536.4 5544.1 5319.9 5403.2 5411.3 5412.2 5414.0 4135.2 4141.6 4166.2 4169.9 4175.3 4099.5 4155.8 4174.7 4175.0 4191.5 4130.8 4137.4 4138.6 4140.3 4162.2 4110.5 4111.1 4111.7 4114.1 4115.2 3545.4 3621.8 3630.0 3634.7 3638.7 5274.9 5289.4 5301.4 5337.5 5370.1 4870.5 4894.1 4894.9 4903.9 4907.7 5595.3 5669.3 5726.7 5755.6 5769.5 4080.1 4084.7 4087.6 4106.9 4112.8 5753.3 5853.3 5961.3 6046.5 6140.0 4088.3 4096.2 4117.7 4126.8 4135.2 4172.7 4187.2 4197.5 4201.2 4203.6 4726.1 4761.2 4791.7 4811.9 4817.0 5751.2 5764.3 5769.4 5769.9 5777.0 1449.9 1459.5 1459.9 1462.3 1465.7 950.2 967.3 1000.5 1003.6 1003.7 4926.5 4939.7 4942.8 4945.9 4950.9 5904.1 5935.5 5958.6 5973.7 5979.8 4795.7 4896.9 4902.3 4914.5 4940.4 3124.5 3146.3 3146.5 3147.7 3166.5 5427.3 5498.1 5518.8 5521.7 5525.4 6044.6 6104.0 6109.5 6144.8 6151.8 5508.8 5515.8 5518.0 5519.4 5521.8 5877.4 5889.9 5916.5 5919.9 5945.0 5827.0 5840.5 5848.8 5858.5 5859.3 5272.8 5316.2 5426.5 5479.3 5492.9 4187.0 4193.0 4199.3 4199.9 4199.9 5792.0 5967.2 5993.6 6013.2 6026.5 5778.1 5807.2 5832.7 5835.6 5839.5 5585.1 5771.9 5809.4 5836.6 5837.4 5696.4 5720.1 5724.7 5727.3 5764.2 5707.5 5815.8 5831.5 5848.7 5860.6 5639.7 5653.9 5677.4 5684.1 5691.3 16:56:16 INFO - PID 18319 | 16:56:16 INFO - PID 18319 | [#5] yui.html Cycles:180 Average:18336.76 Median:18682.67 stddev:24264.36 (129.9%) stddev-sans-first:24296.26 16:56:16 INFO - PID 18319 | Values: 693.3 713.3 743.4 751.0 767.3 12765.9 13089.1 13977.7 14894.9 14920.0 15399.5 16054.8 16071.9 16127.3 16134.5 886.8 909.2 916.6 917.6 919.7 907.3 911.6 912.4 912.9 917.6 920.7 952.6 952.6 953.2 954.9 941.7 948.7 951.4 952.6 955.1 690.9 691.9 695.1 695.8 697.0 15170.0 15330.5 15419.8 15493.0 15515.5 16279.4 16575.9 16692.4 16704.2 16735.2 12390.4 13008.3 13236.5 13250.6 13300.8 3104.6 3107.8 3127.1 3128.3 3137.0 74014.3 86983.0 88656.6 89933.1 90889.0 12923.2 13150.1 13302.7 13344.6 13364.0 23786.4 24507.0 24527.4 24627.3 24629.1 6407.0 6599.4 6646.4 6668.1 6693.2 3079.2 3117.8 3135.1 3142.7 3147.2 3678.5 3767.9 3771.1 3771.2 3776.7 794.9 822.1 823.2 827.1 834.4 603.5 611.0 611.2 613.6 631.1 9814.8 10391.3 10555.5 11329.3 11633.8 621.1 629.8 630.2 631.2 638.5 4894.6 4999.1 5066.4 5077.3 5226.3 90618.0 90928.0 91283.0 93117.5 93722.5 78909.2 79678.0 79755.6 80373.2 80893.0 59511.0 64535.7 64988.4 65430.0 66034.7 9654.5 10690.9 10772.9 10778.5 10788.8 27277.2 27560.2 28020.7 28589.0 28738.1 33686.8 49674.0 50773.5 51270.0 51342.7 14603.0 14640.4 15016.8 15020.4 15384.9 16922.9 16980.7 17043.7 17224.5 17383.5 14457.9 14520.2 15000.0 15693.7 15795.9 15169.8 15334.0 15382.6 15521.7 15712.1 14753.6 14814.3 14999.6 15221.7 15408.5 9793.5 9892.6 9973.5 10166.5 10322.6 11746.2 12348.7 12539.5 12578.4 12625.1 16:56:16 INFO - PID 18319 | -------- Summary: end -------- 16:56:16 INFO - PID 18319 | 16:56:17 INFO - TEST-INFO | 18319: exit 0 16:56:17 INFO - TEST-OK | dromaeo_css | took 1148565ms 16:56:17 INFO - TEST-START | kraken 16:56:17 INFO - operating with platform_type : linux_ 16:56:17 INFO - Initialising browser for kraken test... 16:56:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html -profile /tmp/tmp7kggFy/profile 16:56:17 INFO - TEST-INFO | started process 18724 (/builds/slave/test/build/application/firefox/firefox http://localhost:60078/getInfo.html) 16:56:52 INFO - TEST-INFO | 18724: killed by SIGTERM 16:56:52 INFO - Browser initialized. 16:56:52 INFO - Running cycle 1/1 for kraken test... 16:56:52 INFO - TEST-INFO | started process 18923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kggFy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:04 INFO - PID 18923 | RSS: Main: 183255040 16:57:04 INFO - PID 18923 | 16:57:07 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:08 INFO - PID 18923 | RSS: Main: 187518976 16:57:08 INFO - PID 18923 | 16:57:11 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-dft) 16:57:11 INFO - PID 18923 | RSS: Main: 185671680 16:57:11 INFO - PID 18923 | 16:57:14 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-fft) 16:57:15 INFO - PID 18923 | RSS: Main: 182136832 16:57:15 INFO - PID 18923 | 16:57:17 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60078/tests/kraken/driver.html?testName=audio-oscillator) 16:57:18 INFO - PID 18923 | RSS: Main: 182284288 16:57:18 INFO - PID 18923 | 16:57:20 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:20 INFO - PID 18923 | RSS: Main: 183119872 16:57:20 INFO - PID 18923 | 16:57:23 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60078/tests/kraken/driver.html?testName=imaging-darkroom) 16:57:24 INFO - PID 18923 | RSS: Main: 186920960 16:57:24 INFO - PID 18923 | 16:57:28 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60078/tests/kraken/driver.html?testName=imaging-desaturate) 16:57:28 INFO - PID 18923 | RSS: Main: 183046144 16:57:28 INFO - PID 18923 | 16:57:31 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60078/tests/kraken/driver.html?testName=json-parse-financial) 16:57:32 INFO - PID 18923 | RSS: Main: 183451648 16:57:32 INFO - PID 18923 | 16:57:33 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:57:34 INFO - PID 18923 | RSS: Main: 183730176 16:57:34 INFO - PID 18923 | 16:57:36 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:57:36 INFO - PID 18923 | RSS: Main: 183037952 16:57:36 INFO - PID 18923 | 16:57:39 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:57:39 INFO - PID 18923 | RSS: Main: 182820864 16:57:39 INFO - PID 18923 | 16:57:42 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:57:43 INFO - PID 18923 | RSS: Main: 182882304 16:57:43 INFO - PID 18923 | 16:57:46 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:57:47 INFO - PID 18923 | RSS: Main: 182804480 16:57:47 INFO - PID 18923 | 16:57:48 INFO - PID 18923 | Cycle 1(1): loaded http://localhost:60078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60078/tests/kraken/driver.html?testName=ai-astar) 16:57:49 INFO - PID 18923 | RSS: Main: 184471552 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | __start_tp_report 16:57:49 INFO - PID 18923 | _x_x_mozilla_page_load 16:57:49 INFO - PID 18923 | _x_x_mozilla_page_load_details 16:57:49 INFO - PID 18923 | |i|pagename|runs| 16:57:49 INFO - PID 18923 | |0;ai-astar;104;111;110;113;112;110;110;111;110;111 16:57:49 INFO - PID 18923 | |1;audio-beat-detection;152;123;125;191;122;121;123;122;146;124 16:57:49 INFO - PID 18923 | |2;audio-dft;164;164;165;169;168;174;164;163;162;163 16:57:49 INFO - PID 18923 | |3;audio-fft;75;76;76;114;80;73;73;78;91;73 16:57:49 INFO - PID 18923 | |4;audio-oscillator;84;84;107;84;84;83;114;87;83;104 16:57:49 INFO - PID 18923 | |5;imaging-gaussian-blur;115;115;116;115;117;115;115;114;113;115 16:57:49 INFO - PID 18923 | |6;imaging-darkroom;151;152;151;151;150;152;151;151;151;151 16:57:49 INFO - PID 18923 | |7;imaging-desaturate;94;95;95;95;94;94;95;95;95;94 16:57:49 INFO - PID 18923 | |8;json-parse-financial;54;54;56;55;56;61;62;56;58;55 16:57:49 INFO - PID 18923 | |9;json-stringify-tinderbox;56;56;57;57;56;57;56;57;56;56 16:57:49 INFO - PID 18923 | |10;stanford-crypto-aes;86;86;86;85;88;88;93;87;132;86 16:57:49 INFO - PID 18923 | |11;stanford-crypto-ccm;144;131;134;130;131;133;131;144;130;142 16:57:49 INFO - PID 18923 | |12;stanford-crypto-pbkdf2;191;194;187;192;188;190;190;191;190;188 16:57:49 INFO - PID 18923 | |13;stanford-crypto-sha256-iterative;73;75;71;74;73;73;72;74;71;70 16:57:49 INFO - PID 18923 | __end_tp_report 16:57:49 INFO - PID 18923 | __start_cc_report 16:57:49 INFO - PID 18923 | _x_x_mozilla_cycle_collect,1026 16:57:49 INFO - PID 18923 | __end_cc_report 16:57:49 INFO - PID 18923 | __startTimestamp1496015869138__endTimestamp 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | ------- Summary: start ------- 16:57:49 INFO - PID 18923 | Number of tests: 14 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.39 (2.2%) stddev-sans-first:1.05 16:57:49 INFO - PID 18923 | Values: 104.0 111.0 110.0 113.0 112.0 110.0 110.0 111.0 110.0 111.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:124.50 stddev:22.58 (18.1%) stddev-sans-first:23.09 16:57:49 INFO - PID 18923 | Values: 152.0 123.0 125.0 191.0 122.0 121.0 123.0 122.0 146.0 124.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:3.69 (2.2%) stddev-sans-first:3.87 16:57:49 INFO - PID 18923 | Values: 164.0 164.0 165.0 169.0 168.0 174.0 164.0 163.0 162.0 163.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.81 (16.9%) stddev-sans-first:13.41 16:57:49 INFO - PID 18923 | Values: 75.0 76.0 76.0 114.0 80.0 73.0 73.0 78.0 91.0 73.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:84.00 stddev:11.98 (14.3%) stddev-sans-first:12.41 16:57:49 INFO - PID 18923 | Values: 84.0 84.0 107.0 84.0 84.0 83.0 114.0 87.0 83.0 104.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 16:57:49 INFO - PID 18923 | Values: 115.0 115.0 116.0 115.0 117.0 115.0 115.0 114.0 113.0 115.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 16:57:49 INFO - PID 18923 | Values: 151.0 152.0 151.0 151.0 150.0 152.0 151.0 151.0 151.0 151.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:57:49 INFO - PID 18923 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:2.79 (5.0%) stddev-sans-first:2.78 16:57:49 INFO - PID 18923 | Values: 54.0 54.0 56.0 55.0 56.0 61.0 62.0 56.0 58.0 55.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 16:57:49 INFO - PID 18923 | Values: 56.0 56.0 57.0 57.0 56.0 57.0 56.0 57.0 56.0 56.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:86.50 stddev:14.34 (16.6%) stddev-sans-first:15.06 16:57:49 INFO - PID 18923 | Values: 86.0 86.0 86.0 85.0 88.0 88.0 93.0 87.0 132.0 86.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:133.50 stddev:5.91 (4.4%) stddev-sans-first:5.29 16:57:49 INFO - PID 18923 | Values: 144.0 131.0 134.0 130.0 131.0 133.0 131.0 144.0 130.0 142.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.10 Median:190.50 stddev:2.08 (1.1%) stddev-sans-first:2.18 16:57:49 INFO - PID 18923 | Values: 191.0 194.0 187.0 192.0 188.0 190.0 190.0 191.0 190.0 188.0 16:57:49 INFO - PID 18923 | 16:57:49 INFO - PID 18923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 16:57:49 INFO - PID 18923 | Values: 73.0 75.0 71.0 74.0 73.0 73.0 72.0 74.0 71.0 70.0 16:57:49 INFO - PID 18923 | -------- Summary: end -------- 16:57:49 INFO - PID 18923 | 16:57:50 INFO - TEST-INFO | 18923: exit 0 16:57:50 INFO - TEST-OK | kraken | took 92839ms 16:57:50 INFO - SUITE-END | took 1241s 16:57:50 INFO - Completed test suite (00:20:41) 16:57:50 INFO - javascript benchmark 16:57:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6833.548863548784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2752.1055656911503, 2752.7109653486395, 2777.3334399744067, 2792.7905407094468, 2792.804503684743, 5169.844904652857, 5245.86885327866, 5288.259643649887, 5303.992241474122, 5350.151805688715, 5290.470952904708, 5298.788048478066, 5307.73461326934, 5344.652597581155, 5406.02691515527, 4618.261078227484, 4706.058788242357, 4753.382060332152, 4757.048590281957, 4803.495632958541, 4772.117158325704, 4801.039792041588, 4827.0, 4828.082664293773, 4841.7337046462435, 4676.579107880307, 4686.601638860701, 4704.01215744694, 4771.475137734847, 4796.856094317176, 4745.810167593292, 4757.809687612491, 4776.832810851603, 4787.54518320759, 4797.160496913061, 4696.131215725068, 4700.482946875841, 4719.126961512131, 4720.291956206562, 4720.33915251865, 5191.0656081905245, 5271.130263506517, 5288.603354748371, 5293.153095504739, 5314.707691077027, 5699.658020518741, 5726.513246374063, 5741.224934633813, 5819.6508209507565, 5826.854328641775, 5840.153177789197, 5840.766369345221, 5850.736716847752, 5858.648481091148, 5909.704514774244, 5370.946290537123, 5387.649802762886, 5399.892002159935, 5404.378496472956, 5406.83779486616, 5749.88500229993, 5858.7070646468355, 5919.6152250103605, 5932.110183472513, 5965.28416590012, 5668.489835914787, 5675.517581005578, 5695.0, 5709.457601527848, 5724.942750572524, 5654.886902261932, 5771.047777116729, 5778.075507918713, 5778.624389414675, 5782.421757824184, 5610.803621873215, 5693.259876216148, 5732.111522713986, 5739.397363276796, 5742.339630942495, 5673.262475878109, 5676.489115979582, 5716.799912003143, 5765.509931655773, 5766.106253530709, 4746.098241334135, 4749.4775574686755, 4776.188048031843, 4784.234522476457, 4800.991791723707, 4074.572169922175, 4077.612626800449, 4081.5714349992822, 4081.795910204478, 4121.814518346621, 4742.359781429532, 4760.642951778561, 4809.326694262806, 4855.448665200426, 4891.119598472309, 5799.159121927297, 5811.27359080115, 5824.126381042877, 5842.912356314659, 5854.063349864001, 4801.855944321676, 4803.1114243864995, 4806.086843499794, 4806.44725856524, 4851.126797176472, 4969.850904472727, 5027.572656324181, 5028.7737051832755, 5034.672746271481, 5068.797248110108, 5297.894042119213, 5303.893922121613, 5341.359036915595, 5355.651882627617, 5370.436104209158, 5624.128260119688, 5731.770729170787, 5732.71336433185, 5769.59612827098, 5784.421557844182, 5292.232626269092, 5337.733113344239, 5346.866328341823, 5387.434319396407, 5389.110796718497, 5677.176809362537, 5683.943160568341, 5689.402612725604, 5697.116946873241, 5699.145128230799, 5665.801696940587, 5741.712914354349, 5746.741396637078, 5799.246098007232, 5822.3304320003745, 5610.074337734228, 5632.901584191207, 5651.067573850433, 5655.604107712586, 5678.77284908599, 5577.330720313588, 5592.86017849557, 5600.271964644733, 5610.607257491936, 5614.101743720985, 5394.595405344537, 5525.143602741581, 5544.972275138599, 5553.6390134641115, 5554.888902222014, 5556.777728890799, 5571.916421253765, 5603.719814009365, 5616.578756593353, 5627.493525582717, 5483.479069488392, 5488.807891723771, 5502.119660854244, 5502.614816962774, 5526.005319042611], "value": 5202.898722158572, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.7678835619176, 717.4941666125383, 728.9744858929938, 1080.4057768227478, 1093.573506332531, 33324.833375833114, 34517.82741086294, 34591.0, 34639.48040779384, 34697.0, 35229.0, 35717.46423803645, 35782.8210858946, 35794.64205357945, 35809.0, 6689.8662026759675, 6888.0, 6982.2319544850025, 7128.85742285154, 7132.609141217465, 6853.897191542131, 6894.793156205297, 6915.1701795784575, 6927.7228910843505, 6956.513044086916, 6899.413549848269, 6908.861822763567, 6945.166580010406, 6946.444284457231, 6960.617166055865, 6898.965505172467, 6906.309369063104, 6922.480813938924, 6925.3074692530345, 6944.72221111155, 6770.695318710621, 6793.626350550718, 6794.3545363190915, 6826.0, 6829.180498340182, 31815.522767158513, 32026.0, 32032.519512207335, 32137.196570085936, 32187.0, 3071.262896904749, 3107.6115485564305, 3107.7047680470546, 3109.657937626859, 3112.3464072544566, 25209.747902520925, 25268.494630107478, 25313.746862531323, 25376.0, 25395.61906571403, 3004.8647810848565, 3019.8037127586636, 3048.9390212195854, 3051.0, 3058.357744873579, 117173.0, 118295.99999999914, 135055.0, 136496.0, 136672.31663841716, 40004.0, 40526.79736601298, 40644.593554064675, 40656.59343406587, 40718.0, 41960.58039419628, 42134.57865421368, 42148.57851421508, 42170.36744448836, 42179.36730949038, 12335.6916077097, 12604.558840440724, 12623.368831558386, 12637.368131593383, 12670.873291267153, 10132.797344053226, 10159.288849780445, 10172.949135254275, 10203.081722644998, 10274.794504109876, 13129.67175820593, 13145.474181032843, 13145.67135821593, 13169.209847409185, 13202.801957970638, 5424.430434804289, 5478.0, 5513.393526712059, 5521.282233309725, 5539.833804985857, 851.3146916731966, 894.7271082319825, 904.742148487691, 911.7674992876906, 926.282131348197, 20780.480487987923, 20967.895160524404, 25713.0, 26812.195634131007, 27060.1881943542, 958.4441024205944, 962.821877952567, 982.2044144243185, 984.5028260728286, 987.0918754745651, 11288.0, 11474.0, 11740.765184696429, 11758.941205293919, 11805.822912656316, 173848.0, 176166.0, 176453.0, 176628.0, 176865.0, 41374.58625413707, 41643.7917810409, 41762.373564396556, 41924.790376048535, 41987.1602567953, 1185.5968970550055, 1212.5695378140808, 1223.9143259971895, 1227.4476485581702, 1235.197121870791, 20017.59964800725, 20558.691619626017, 21014.0, 21151.788482114982, 21463.678044829026, 30644.540331895485, 31100.533491998092, 32092.83953580217, 32706.182345441553, 37246.44130337993, 136628.0, 137993.3100334492, 138639.0, 138768.0, 139016.0, 28881.42237155203, 29371.11886643404, 29665.5550166752, 29694.109176724734, 29707.702922970493, 35623.465648015816, 36298.27403451969, 36380.63619363772, 36657.816710916275, 36852.447213292355, 27183.86408067947, 27377.726222737518, 27437.725622744314, 27682.86158569275, 28960.85519572473, 26958.595621065306, 27478.313042174104, 27751.722482774912, 27778.0, 29084.418311633224, 29787.404251914406, 30123.246918827204, 30271.243218919702, 30744.0, 31187.064388068393, 27041.72958270471, 27170.32074198161, 28521.42957140887, 28610.713892860804, 28885.711142888304, 19926.0, 22742.20402285912, 22784.063354615042, 22983.77016229883, 23053.19313824008], "value": 14606.046467052482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.36223302812743, 424.09067970963855, 428.5757100470533, 443.8313440892461, 450.84671211787963, 17152.142392880352, 17842.821571784294, 17949.19228634711, 18205.7269140963, 18676.719849202273, 18712.345067922626, 18782.154803033864, 18829.0, 18847.434576962714, 18982.810171898313, 5277.102892508264, 5288.762005709743, 5427.348718153827, 5504.752286147113, 5505.752241149138, 5290.312259406272, 5355.625106242545, 5387.19192121181, 5403.756830942597, 5415.079436495786, 5175.146100893348, 5307.0, 5320.9467905321035, 5322.787088516455, 5325.360956685203, 5288.312519372476, 5360.59795515334, 5396.568274538027, 5405.297311349519, 5408.296921400232, 4647.976760116211, 4870.293807397943, 4875.171220892456, 4877.829275975359, 4884.926726099111, 21502.892485537628, 21982.560348792933, 22069.558608827734, 22136.0, 22178.338599368017, 1564.9217539123113, 1588.285271627772, 1594.4180374163464, 1595.3459081776416, 1615.3861532617648, 14339.713205735827, 14631.195284259362, 14716.0, 14759.557213283619, 15070.849291507055, 2048.078364735875, 2090.1325949730995, 2102.8317734581196, 2135.177956486764, 2157.8273738100916, 74788.0, 85173.0, 87675.56162219212, 88361.11638883593, 90702.5464872678, 10734.409607471507, 10947.397893115955, 11175.0, 11186.272892261977, 11204.551817927355, 15861.841381586268, 15898.76151857723, 15906.681866362607, 15911.124888131033, 15924.363025479082, 7097.964510177416, 7267.382272506896, 7319.780406587811, 7383.483156179016, 7387.409007279405, 6318.936810631927, 6382.808515744535, 6530.869382612416, 6576.5067619928695, 6578.0, 7043.9647801761685, 7078.539894906815, 7117.572945623279, 7186.173590037108, 7205.7838264852135, 2076.512019675375, 2093.654546999728, 2131.083634037379, 2147.516808718026, 2247.224707475918, 829.9004119505698, 853.1127627267696, 884.1909652667865, 888.391451855481, 891.7503099132254, 17087.401940932257, 17151.0, 17189.04651930063, 17731.645367092842, 17932.55168620795, 859.7893516088599, 865.446114486729, 870.4646642314931, 877.241186373782, 894.2935081285711, 9144.588493517807, 9429.764255893657, 9706.077922597342, 9755.0, 9882.851757223647, 355837.0, 358153.0, 361041.70103840093, 363051.0, 366854.0, 73600.63199683967, 74054.0, 74854.25145748582, 75024.0, 75066.0, 1029.2126523209752, 1039.9480025998669, 1048.6644273832453, 1051.2115913065202, 1059.8622179116664, 14505.78241326402, 14747.115173089649, 14786.334614942569, 14891.25543722788, 15325.927185096936, 37182.256354873294, 37568.43647345347, 38010.61989380181, 38377.61622383852, 39009.80495097506, 45486.0, 46565.53434465612, 46786.29820552626, 47133.7643311795, 48006.519934800206, 8101.797455063671, 8106.270435660819, 8107.554084525408, 8260.793480163044, 8446.070932197576, 12414.379281035732, 12924.870751292367, 13130.146540474838, 13233.735325293634, 13262.336883155996, 10329.12202462799, 10598.25812193139, 10815.945920270347, 11137.71437425945, 11230.708468526223, 10569.894301056891, 10666.146708263475, 10809.56761729522, 10889.292196007234, 10911.290766100177, 10878.836817447904, 11011.72470688207, 11122.0, 11168.720781980515, 11557.768844622893, 8284.295834853863, 8442.451240669337, 8474.830503389774, 8602.440841345542, 8616.396852220285, 10381.584736610452, 10771.407572583583, 11103.50034248477, 11156.10751139923, 11270.380129092979], "value": 8754.685140200418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.9876401235986, 1294.5210272199288, 1297.156848048768, 1298.0589072922132, 1299.746549422863, 10319.43243121628, 10782.353058816476, 10899.83650245246, 10923.235373523856, 11131.165162612817, 10897.0, 11093.667189984293, 11100.777984440327, 11113.83329250062, 11129.109671226302, 2118.883461409618, 2174.8151407130413, 2176.4014895903597, 2182.378022263655, 2186.1255497800926, 2146.7853214678485, 2188.102877820094, 2189.748178959424, 2196.9780302197014, 2203.394066631673, 2101.8003289687454, 2110.0610228448345, 2123.087072558807, 2123.893805309736, 2126.797954194349, 2079.334612923865, 2085.9687104693444, 2089.2896415218747, 2098.653722135846, 2100.6953991671276, 1852.8888266704041, 1927.9710804337806, 2064.865783724053, 2097.7272954515815, 2111.144986280559, 10522.053015228666, 10576.788464230749, 10578.576856925714, 10583.947080264626, 10590.09984151348, 5559.277293951801, 5758.107493338539, 5759.539236861041, 5763.1355296705415, 5770.394108618577, 3371.1740623547144, 3499.6675315844955, 3575.803330816804, 3580.7493475456727, 3596.6762991330907, 1122.7586068995206, 1142.731458107344, 1155.7110722319421, 1166.2186335155382, 1171.94140292985, 15714.0, 15881.126538040404, 15889.602759930978, 16003.51989440307, 16011.359545618161, 4640.118377508263, 4779.593734532534, 4895.437024742129, 4902.117618828645, 4902.975485122552, 11346.262492937933, 11353.772924541629, 11366.261193022427, 11388.829167562493, 11410.771784564262, 5488.807891723771, 5713.05734553794, 5713.942860571341, 5726.3700992890745, 5732.971335143381, 5173.094708426011, 5253.605979551549, 5267.0, 5285.894282114336, 5311.044012077863, 3908.804559772, 3976.463177471004, 4001.1197536541913, 4059.3505039193587, 4064.4106604542767, 1171.3323405658693, 1191.3566673996118, 1192.3203773848995, 1194.6834088966432, 1207.3540655749132, 663.8174502011985, 686.9381755642016, 689.3864460630043, 707.4163814852767, 712.2770388056127, 5363.141897296414, 5452.318460192476, 5498.395176530578, 5624.606277560613, 5638.2670252866865, 541.5856869494839, 544.064209559557, 549.8680316723958, 550.9641873278224, 552.0890530624501, 3395.2700169463683, 3405.1997780521556, 3510.7191424685966, 3520.331137083946, 3732.402815549499, 13656.0, 14154.363053662404, 14283.857161428461, 14342.49801256951, 14396.784048239284, 13548.45806167762, 14313.212773297568, 14326.856731432761, 14328.641783955276, 14331.78502322466, 7020.5787652741, 7161.713531458891, 7246.058012458347, 7263.273672632695, 7291.562506249642, 5674.347450043298, 5811.651300921958, 5824.009918313982, 5844.883102338014, 6061.1514387984835, 12373.876261237272, 12440.564580239648, 12484.188527745668, 12508.874911251136, 12632.621021369374, 12322.075844311892, 12772.744545109232, 12805.103642744918, 12997.350132493526, 13007.284599347127, 8417.368697347601, 8450.366222533212, 8500.319974402157, 8519.446235994641, 8582.78543036429, 9847.359921605073, 9870.407775533491, 9961.50192490387, 9965.302428829913, 9995.350302230332, 8340.207680270365, 8426.283765879969, 8497.957510212409, 8622.094680058504, 8709.608067636846, 8371.455855369382, 8413.747587572383, 8448.83102337962, 8537.274331681876, 8788.780280492783, 6930.61881596517, 7077.186123595852, 7082.716691332289, 7092.255313192247, 7102.289771023063, 4895.7062576245535, 5457.481539253765, 5483.616146869681, 5587.217789509391, 5702.657840529581, 5293.206019097166, 5333.813316533902, 5362.973185134206, 5390.27231323782, 5405.5135037846785], "value": 4759.2378467598855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.69136653627294, 388.3126865448157, 400.1556715330652, 400.20359484625595, 401.24966312994707, 5387.164989426636, 5489.396166421696, 5514.80698175564, 5536.363318218406, 5544.08935308963, 5319.946800531993, 5403.162509810985, 5411.269478620385, 5412.2422860799425, 5413.972930135354, 4135.214309281227, 4141.606547378002, 4166.208420400114, 4169.937450938239, 4175.31107367284, 4099.544661645118, 4155.792210389468, 4174.686898482611, 4174.958250417502, 4191.476065491814, 4130.834766609332, 4137.420761093449, 4138.627523522882, 4140.254754144253, 4162.209180255757, 4110.527289361702, 4111.075008123148, 4111.732737372061, 4114.053767633446, 4115.156392939441, 3545.3795585772386, 3621.7826930384263, 3629.981850090759, 3634.745567810254, 3638.7089032877307, 5274.918641678447, 5289.365276166846, 5301.443348448396, 5337.5196232338885, 5370.140777475585, 4870.537298956593, 4894.119058569456, 4894.926576101361, 4903.8774030649165, 4907.730074845882, 5595.300587426572, 5669.291338582677, 5726.711489914777, 5755.597108202427, 5769.480746732772, 4080.10237747695, 4084.6936479764136, 4087.570805065485, 4106.917861642781, 4112.8149233284275, 5753.280839895013, 5853.326867410302, 5961.314448838396, 6046.455818976313, 6139.969300153515, 4088.284550203762, 4096.221717873595, 4117.691173161965, 4126.834926602903, 4135.152293779768, 4172.749635021848, 4187.183499217685, 4197.543193847985, 4201.243776120266, 4203.642690371292, 4726.1020406122725, 4761.166795810719, 4791.676037121993, 4811.927821082687, 4817.0, 5751.22358481608, 5764.308283006066, 5769.365369809318, 5769.8557536061935, 5777.0, 1449.9420023198954, 1459.547540262522, 1459.9051061680957, 1462.3200211901517, 1465.7215129125432, 950.1955027246782, 967.2842096848423, 1000.51975051974, 1003.5534187286587, 1003.7390278527636, 4926.5073492650445, 4939.703617782944, 4942.827001054946, 4945.9258111128365, 4950.9009819803405, 5904.106987576057, 5935.52515798735, 5958.582899197015, 5973.701314934236, 5979.833932383231, 4795.736234507066, 4896.853094407174, 4902.338184345139, 4914.533119353656, 4940.407151141814, 3124.453220686371, 3146.3392687535875, 3146.5437511560694, 3147.7009684079976, 3166.493361062219, 5427.348718153847, 5498.120300751861, 5518.806841760519, 5521.696306703089, 5525.392206857243, 6044.576879618385, 6103.95517501633, 6109.450149486567, 6144.754209831557, 6151.7539298428455, 5508.779648814003, 5515.806946756844, 5518.0, 5519.420460851553, 5521.806736764194, 5877.353491115889, 5889.94110058894, 5916.526677865846, 5919.921640746701, 5944.970275148597, 5827.038538641246, 5840.54697027258, 5848.795292164924, 5858.502027327554, 5859.267591551056, 5272.841814745564, 5316.202569614588, 5426.511613954763, 5479.287692599936, 5492.91760623583, 4186.979065104655, 4192.981053641373, 4199.349100889367, 4199.853005144805, 4199.916001680011, 5791.971040144772, 5967.194428752063, 5993.640381577119, 6013.158157857816, 6026.517878569792, 5778.133280008033, 5807.216025836458, 5832.737526811219, 5835.56233282497, 5839.5036421904615, 5585.106382978704, 5771.913421298768, 5809.360970293349, 5836.649801011953, 5837.445442682938, 5696.401877802937, 5720.141978703228, 5724.685142317213, 5727.336788393417, 5764.2043608848835, 5707.543396528351, 5815.8255252340805, 5831.504322132666, 5848.678322692293, 5860.619059761102, 5639.746211420414, 5653.858653533694, 5677.403872593318, 5684.118961560965, 5691.292612216236], "value": 4321.201741881631, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.2686016252851, 713.3187805645609, 743.4275607782007, 750.9899185595376, 767.3094215206314, 12765.872341276585, 13089.083764136514, 13977.650558736037, 14894.925525372371, 14920.030198037133, 15399.461018864342, 16054.75917861233, 16071.919640401811, 16127.274272657729, 16134.515964521082, 886.844802159621, 909.2316992141663, 916.6104405627582, 917.6283605139896, 919.6781126605702, 907.3059109781022, 911.6171208092617, 912.4297314178639, 912.8813254276935, 917.6467060181844, 920.6501529418812, 952.5618215620823, 952.6141912525403, 953.2183609440261, 954.9331546791727, 941.6657086734214, 948.6821914658598, 951.4148798488949, 952.552300418802, 955.0544960489066, 690.9481788865855, 691.934266244711, 695.1345574759457, 695.7564852301705, 697.010245451455, 15170.0, 15330.463433779876, 15419.845801542066, 15493.0, 15515.45695900638, 16279.430219942245, 16575.91712041444, 16692.415765448273, 16704.164791760362, 16735.246913888903, 12390.380480976006, 13008.34958252093, 13236.470541178342, 13250.602481925558, 13300.80048799259, 3104.5653608494827, 3107.7669174811754, 3127.0618814355603, 3128.264857758425, 3137.0118412700153, 74014.25985740128, 86983.0, 88656.55671721665, 89933.10066899312, 90889.0, 12923.22460652364, 13150.079494435298, 13302.733945321039, 13344.599662010156, 13364.0, 23786.405339866295, 24507.0, 24527.386815329402, 24627.261182164562, 24629.137980170966, 6407.0, 6599.406053455212, 6646.4350530205475, 6668.099806526154, 6693.196816382066, 3079.2455848317304, 3117.7505799535984, 3135.0908236611585, 3142.6857314268846, 3147.244661281276, 3678.503402040744, 3767.9246415072093, 3771.07608635886, 3771.245750849841, 3776.678982286536, 794.9483283586549, 822.0874828939872, 823.168599714281, 827.123249355685, 834.4117397235057, 603.4900509069829, 610.9755609775559, 611.1901730207404, 613.6287546034584, 631.1321932343028, 9814.803703926023, 10391.324563903323, 10555.525001374957, 11329.320240785579, 11633.767324653629, 621.0963048764038, 629.8173529676343, 630.2437075509407, 631.182618509032, 638.4796390941368, 4894.632902532324, 4999.125153098194, 5066.404082713933, 5077.314562534085, 5226.268322434862, 90618.0, 90928.0, 91283.0, 93117.5344123275, 93722.53138734262, 78909.21090789018, 79678.0, 79755.60122199352, 80373.19626803775, 80893.0, 59511.0, 64535.67732161309, 64988.35011649823, 65430.0, 66034.66982665056, 9654.469004204837, 10690.893091069302, 10772.946135269587, 10778.514966826355, 10788.838167427652, 27277.181684549494, 27560.17319480419, 28020.719792802625, 28589.0, 28738.13785586436, 33686.83156584201, 49674.0, 50773.49226507688, 51270.0, 51342.74328628333, 14602.97779155449, 14640.414383424544, 15016.774748378564, 15020.399184032953, 15384.923075384999, 16922.915385422995, 16980.660386792442, 17043.659126817147, 17224.483265502055, 17383.47849564515, 14457.855421446071, 14520.201388923288, 15000.024998375071, 15693.686126277182, 15795.921020394824, 15169.848301517284, 15334.0, 15382.615434614225, 15521.68956620884, 15712.057276563442, 14753.55739327779, 14814.25928703539, 14999.625009374417, 15221.695566088838, 15408.460703875311, 9793.461359625004, 9892.604295828374, 9973.451460169761, 10166.491675416348, 10322.587096516056, 11746.177767556532, 12348.691282718004, 12539.49842006346, 12578.371081445708, 12625.116241862981], "value": 7441.931941965467, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 113.0, 112.0, 110.0, 110.0, 111.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 125.0, 191.0, 122.0, 121.0, 123.0, 122.0, 146.0, 124.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 169.0, 168.0, 174.0, 164.0, 163.0, 162.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 80.0, 73.0, 73.0, 78.0, 91.0, 73.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 107.0, 84.0, 84.0, 83.0, 114.0, 87.0, 83.0, 104.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 116.0, 115.0, 117.0, 115.0, 115.0, 114.0, 113.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 151.0, 150.0, 152.0, 151.0, 151.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 56.0, 61.0, 62.0, 56.0, 58.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 56.0, 57.0, 56.0, 57.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 88.0, 88.0, 93.0, 87.0, 132.0, 86.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 131.0, 134.0, 130.0, 131.0, 133.0, 131.0, 144.0, 130.0, 142.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 194.0, 187.0, 192.0, 188.0, 190.0, 190.0, 191.0, 190.0, 188.0], "value": 190.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 71.0, 74.0, 73.0, 73.0, 72.0, 74.0, 71.0, 70.0], "value": 72.6, "unit": "score"}]}]} 16:57:50 INFO - Return code: 0 16:57:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:57:50 INFO - # TBPL SUCCESS # 16:57:50 INFO - Running post-action listener: _resource_record_post_action 16:57:50 INFO - [mozharness: 2017-05-28 23:57:50.944300Z] Finished run-tests step (success) 16:57:50 INFO - Running post-run listener: _resource_record_post_run 16:57:51 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414724096; Read time: 16; Write time: 243172 16:57:51 INFO - TinderboxPrint: CPU usage
12.7% 16:57:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:57:51 INFO - TinderboxPrint: I/O write bytes / time
414,724,096 / 243,172 16:57:51 INFO - TinderboxPrint: CPU idle
8,768.5 (87.3%) 16:57:51 INFO - TinderboxPrint: CPU user
1,219.7 (12.1%) 16:57:51 INFO - TinderboxPrint: Swap in / out
0 / 0 16:57:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84901888; Read time: 0; Write time: 39376 16:57:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:57:51 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306429952; Read time: 16; Write time: 164928 16:57:51 INFO - Running post-run listener: _upload_blobber_files 16:57:51 INFO - Blob upload gear active. 16:57:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:57:51 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 16:57:51 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'] 16:57:51 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 16:57:52 INFO - (blobuploader) - INFO - Open directory for files ... 16:57:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:57:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:58 INFO - (blobuploader) - INFO - Done attempting. 16:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:58 INFO - (blobuploader) - INFO - Done attempting. 16:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:57:59 INFO - (blobuploader) - INFO - Done attempting. 16:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:00 INFO - (blobuploader) - INFO - Done attempting. 16:58:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:58:00 INFO - Return code: 0 16:58:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:58:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:58:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfebffb55855e72b00a290d00324e8d73e88208f2d580e11426955660d37ea37c616b6f664a571a4291926d9fc6a9ceeb9e508c966b3be2f5cc593c6d93f85e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fd4875249701c81f201701516e61d7908a57c302f9fa7f106e12d5d32378c243fb804b4257e636db6c3c26f994367a15e33be86b90e814e9a97ec16600151d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bcdac995d61ec01783decb8cef9cbaa9cc165ae086236eac8cc3ab68984a79b17abaa5847a7bc408d8d136c51c4ec988319a7d7e115f671929f2553d3f813cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4afd1ccca2296e774144948e5f5b7e670e73da915e0a9d0bb305f47819b7892e0d7b2919b70e623c7332b61e1a108c63a5bb117bbccaf2a9c41306ae0294dff8"} 16:58:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:58:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:58:00 INFO - Contents: 16:58:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfebffb55855e72b00a290d00324e8d73e88208f2d580e11426955660d37ea37c616b6f664a571a4291926d9fc6a9ceeb9e508c966b3be2f5cc593c6d93f85e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fd4875249701c81f201701516e61d7908a57c302f9fa7f106e12d5d32378c243fb804b4257e636db6c3c26f994367a15e33be86b90e814e9a97ec16600151d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bcdac995d61ec01783decb8cef9cbaa9cc165ae086236eac8cc3ab68984a79b17abaa5847a7bc408d8d136c51c4ec988319a7d7e115f671929f2553d3f813cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4afd1ccca2296e774144948e5f5b7e670e73da915e0a9d0bb305f47819b7892e0d7b2919b70e623c7332b61e1a108c63a5bb117bbccaf2a9c41306ae0294dff8"} 16:58:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:58:00 INFO - Copying logs to upload dir... 16:58:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:58:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.184143 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-28 16:57:59.785958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:59.789331) ========= 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=cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfebffb55855e72b00a290d00324e8d73e88208f2d580e11426955660d37ea37c616b6f664a571a4291926d9fc6a9ceeb9e508c966b3be2f5cc593c6d93f85e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fd4875249701c81f201701516e61d7908a57c302f9fa7f106e12d5d32378c243fb804b4257e636db6c3c26f994367a15e33be86b90e814e9a97ec16600151d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bcdac995d61ec01783decb8cef9cbaa9cc165ae086236eac8cc3ab68984a79b17abaa5847a7bc408d8d136c51c4ec988319a7d7e115f671929f2553d3f813cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4afd1ccca2296e774144948e5f5b7e670e73da915e0a9d0bb305f47819b7892e0d7b2919b70e623c7332b61e1a108c63a5bb117bbccaf2a9c41306ae0294dff8"} build_url:https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/Zq31C-D7RQq1qgmmXvoCbQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cfebffb55855e72b00a290d00324e8d73e88208f2d580e11426955660d37ea37c616b6f664a571a4291926d9fc6a9ceeb9e508c966b3be2f5cc593c6d93f85e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5fd4875249701c81f201701516e61d7908a57c302f9fa7f106e12d5d32378c243fb804b4257e636db6c3c26f994367a15e33be86b90e814e9a97ec16600151d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bcdac995d61ec01783decb8cef9cbaa9cc165ae086236eac8cc3ab68984a79b17abaa5847a7bc408d8d136c51c4ec988319a7d7e115f671929f2553d3f813cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4afd1ccca2296e774144948e5f5b7e670e73da915e0a9d0bb305f47819b7892e0d7b2919b70e623c7332b61e1a108c63a5bb117bbccaf2a9c41306ae0294dff8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:59.820294) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:59.820601) ========= 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=cbe409c6de289db6ac707de3000001d4-1496014561.226874-645916236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:57:59.901816) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 16:57:59.905143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 16:57:59.905462) ========= ========= Total master_lag: 0.28 =========