builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1496709732.21 results: success (0) revision: f9acc145b45ee96a24859b93bd5389bde4925c5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.209327) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.210157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.210454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.226926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.227320) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 17:42:12-- 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% 42.1M=0s 2017-06-05 17:42:12 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.374885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.375198) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023262 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.428267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:12.428616) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9acc145b45ee96a24859b93bd5389bde4925c5e --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 f9acc145b45ee96a24859b93bd5389bde4925c5e --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=17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 17:42:12,666 truncating revision to first 12 chars 2017-06-05 17:42:12,666 Setting DEBUG logging. 2017-06-05 17:42:12,666 attempt 1/10 2017-06-05 17:42:12,666 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9acc145b45e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 17:42:13,116 unpacking tar archive at: mozilla-central-f9acc145b45e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:13.203309) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:13.206635) ========= script_repo_revision: f9acc145b45ee96a24859b93bd5389bde4925c5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:13.207022) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:13.207287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 17:42:13.229576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-05 17:42:13.229865) ========= /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=17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:42:13 INFO - MultiFileLogger online at 20170605 17:42:13 in /builds/slave/test 17:42:13 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 17:42:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:13 INFO - {'append_to_log': False, 17:42:13 INFO - 'base_work_dir': '/builds/slave/test', 17:42:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:13 INFO - 'branch': 'Firefox-Non-PGO', 17:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:13 INFO - 'config_files': ('talos/linux_config.py',), 17:42:13 INFO - 'default_actions': ('clobber', 17:42:13 INFO - 'read-buildbot-config', 17:42:13 INFO - 'download-and-extract', 17:42:13 INFO - 'populate-webroot', 17:42:13 INFO - 'create-virtualenv', 17:42:13 INFO - 'install', 17:42:13 INFO - 'setup-mitmproxy', 17:42:13 INFO - 'run-tests'), 17:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:13 INFO - 'download_minidump_stackwalk': True, 17:42:13 INFO - 'download_symbols': 'ondemand', 17:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:13 INFO - 'gecko_profile': False, 17:42:13 INFO - 'gecko_profile_interval': 0, 17:42:13 INFO - 'installer_path': 'installer.exe', 17:42:13 INFO - 'log_level': 'info', 17:42:13 INFO - 'log_name': 'talos', 17:42:13 INFO - 'log_to_console': True, 17:42:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:42:13 INFO - 'opt_config_files': (), 17:42:13 INFO - 'pip_index': False, 17:42:13 INFO - 'suite': 'dromaeojs-e10s', 17:42:13 INFO - 'system_bits': '32', 17:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:13 INFO - 'title': 'talos-linux64-ix-009', 17:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:13 INFO - 'use_talos_json': True, 17:42:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:13 INFO - 'work_dir': 'build'} 17:42:13 INFO - [mozharness: 2017-06-06 00:42:13.569626Z] Running clobber step. 17:42:13 INFO - Running pre-action listener: _resource_record_pre_action 17:42:13 INFO - Running main action method: clobber 17:42:13 INFO - rmtree: /builds/slave/test/build 17:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:14 INFO - Running post-action listener: _resource_record_post_action 17:42:14 INFO - [mozharness: 2017-06-06 00:42:14.594625Z] Finished clobber step (success) 17:42:14 INFO - [mozharness: 2017-06-06 00:42:14.594725Z] Running read-buildbot-config step. 17:42:14 INFO - Running pre-action listener: _resource_record_pre_action 17:42:14 INFO - Running main action method: read_buildbot_config 17:42:14 INFO - Using buildbot properties: 17:42:14 INFO - { 17:42:14 INFO - "project": "", 17:42:14 INFO - "product": "firefox", 17:42:14 INFO - "who": "kwierso@gmail.com", 17:42:14 INFO - "installer_path": "public/build/target.tar.bz2", 17:42:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:42:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:42:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:42:14 INFO - "stage_platform": "linux64", 17:42:14 INFO - "basedir": "/builds/slave/test", 17:42:14 INFO - "buildnumber": 657, 17:42:14 INFO - "platform": "ubuntu64_hw", 17:42:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:42:14 INFO - "slavebuilddir": "test", 17:42:14 INFO - "taskId": "HN3BgBJDT0WmaWEUfDcsVQ", 17:42:14 INFO - "branch": "mozilla-central", 17:42:14 INFO - "script_repo_revision": "production", 17:42:14 INFO - "revision": "f9acc145b45ee96a24859b93bd5389bde4925c5e", 17:42:14 INFO - "slavename": "talos-linux64-ix-009", 17:42:14 INFO - "repo_path": "mozilla-central" 17:42:14 INFO - } 17:42:14 INFO - Finding installer, test and symbols from parent task. 17:42:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HN3BgBJDT0WmaWEUfDcsVQ'}, attempt #1 17:42:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HN3BgBJDT0WmaWEUfDcsVQ'}, attempt #1 17:42:15 INFO - Task dependencies: bn8o9jc7QS2EpBADKi7ycg 17:42:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg'}, attempt #1 17:42:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2 17:42:16 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/test_packages.json 17:42:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.crashreporter-symbols.zip 17:42:16 INFO - Running post-action listener: _resource_record_post_action 17:42:16 INFO - [mozharness: 2017-06-06 00:42:16.054344Z] Finished read-buildbot-config step (success) 17:42:16 INFO - [mozharness: 2017-06-06 00:42:16.054565Z] Running download-and-extract step. 17:42:16 INFO - Running pre-action listener: _resource_record_pre_action 17:42:16 INFO - Running main action method: download_and_extract 17:42:16 INFO - mkdir: /builds/slave/test/build/tests 17:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:16 INFO - trying https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.test_packages.json 17:42:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:42:16 INFO - Downloaded 989 bytes. 17:42:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:42:16 INFO - Using the following test package requirements: 17:42:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:42:16 INFO - u'common': [u'target.common.tests.zip'], 17:42:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:42:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:42:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:42:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:42:16 INFO - u'mozbase': [u'target.common.tests.zip'], 17:42:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:42:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:42:16 INFO - u'web-platform': [u'target.common.tests.zip', 17:42:16 INFO - u'target.web-platform.tests.tar.gz'], 17:42:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:42:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:42:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.common.tests.zip 17:42:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:42:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.common.tests.zip into memory 17:42:19 INFO - Content-Length response header: 65103011 17:42:19 INFO - Bytes received: 65103011 17:42:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:42:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.common.tests.zip 17:42:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:42:30 INFO - Fetch https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.common.tests.zip into memory 17:42:32 INFO - Content-Length response header: 65103011 17:42:32 INFO - Bytes received: 65103011 17:42:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.talos.tests.zip 17:42:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:42:43 INFO - Fetch https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.talos.tests.zip into memory 17:42:44 INFO - Content-Length response header: 14447425 17:42:44 INFO - Bytes received: 14447425 17:42:45 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')]} 17:42:45 INFO - trying https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2 17:42:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:42:48 INFO - Downloaded 58661353 bytes. 17:42:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2 17:42:48 INFO - mkdir: /builds/slave/test/properties 17:42:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:48 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:48 INFO - Contents: 17:42:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2 17:42:48 INFO - Running post-action listener: _resource_record_post_action 17:42:48 INFO - Running post-action listener: set_extra_try_arguments 17:42:48 INFO - [mozharness: 2017-06-06 00:42:48.411976Z] Finished download-and-extract step (success) 17:42:48 INFO - [mozharness: 2017-06-06 00:42:48.412203Z] Running populate-webroot step. 17:42:48 INFO - Running pre-action listener: _resource_record_pre_action 17:42:48 INFO - Running main action method: populate_webroot 17:42:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:48 INFO - '--tppagecycles', 17:42:48 INFO - '7'], 17:42:48 INFO - 'tests': ['tsvgm']}}, 17:42:48 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['damp', 'tps']}, 17:42:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'tests': ['damp', 'tps']}, 17:42:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['dromaeo_dom']}, 17:42:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:42:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:42:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:42:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['a11yr', 17:42:48 INFO - 'ts_paint', 17:42:48 INFO - 'tpaint', 17:42:48 INFO - 'sessionrestore', 17:42:48 INFO - 'sessionrestore_no_auto_restore', 17:42:48 INFO - 'tabpaint']}, 17:42:48 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:48 INFO - 'ts_paint', 17:42:48 INFO - 'tpaint', 17:42:48 INFO - 'sessionrestore', 17:42:48 INFO - 'sessionrestore_no_auto_restore', 17:42:48 INFO - 'tabpaint']}, 17:42:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:48 INFO - 'ts_paint', 17:42:48 INFO - 'tpaint', 17:42:48 INFO - 'sessionrestore', 17:42:48 INFO - 'sessionrestore_no_auto_restore', 17:42:48 INFO - 'tabpaint']}, 17:42:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:48 INFO - 'ts_paint', 17:42:48 INFO - 'tpaint', 17:42:48 INFO - 'sessionrestore', 17:42:48 INFO - 'sessionrestore_no_auto_restore', 17:42:48 INFO - 'tabpaint']}, 17:42:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['a11yr', 17:42:48 INFO - 'ts_paint', 17:42:48 INFO - 'tpaint', 17:42:48 INFO - 'sessionrestore', 17:42:48 INFO - 'sessionrestore_no_auto_restore', 17:42:48 INFO - 'tabpaint']}, 17:42:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['a11yr', 17:42:48 INFO - 'ts_paint', 17:42:48 INFO - 'tpaint', 17:42:48 INFO - 'sessionrestore', 17:42:48 INFO - 'sessionrestore_no_auto_restore', 17:42:48 INFO - 'tabpaint']}, 17:42:48 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:42:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:42:48 INFO - 'bloom_basic_ref']}, 17:42:48 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 17:42:48 INFO - 'talos_options': ['--mitmproxy', 17:42:48 INFO - 'mitmproxy-recording-1.mp', 17:42:48 INFO - '--firstNonBlankPaint'], 17:42:48 INFO - 'tests': ['Quantum_1']}, 17:42:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['tsvgx', 17:42:48 INFO - 'tsvgr_opacity', 17:42:48 INFO - 'tart', 17:42:48 INFO - 'tscrollx', 17:42:48 INFO - 'cart', 17:42:48 INFO - 'tsvg_static']}, 17:42:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:48 INFO - 'tsvgr_opacity', 17:42:48 INFO - 'tart', 17:42:48 INFO - 'tscrollx', 17:42:48 INFO - 'cart', 17:42:48 INFO - 'tsvg_static']}, 17:42:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'talos_options': ['--disable-e10s'], 17:42:48 INFO - 'tests': ['tp5o']}, 17:42:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:42:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'talos_options': ['--disable-e10s', 17:42:48 INFO - '--xperf_path', 17:42:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:48 INFO - 'tests': ['tp5n']}, 17:42:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:42:48 INFO - 'talos_options': ['--xperf_path', 17:42:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:48 INFO - 'tests': ['tp5n']}}, 17:42:48 INFO - 'talos.zip': {'path': '', 17:42:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:48 INFO - Running post-action listener: _resource_record_post_action 17:42:48 INFO - [mozharness: 2017-06-06 00:42:48.434878Z] Finished populate-webroot step (success) 17:42:48 INFO - [mozharness: 2017-06-06 00:42:48.434972Z] Running create-virtualenv step. 17:42:48 INFO - Running pre-action listener: _resource_record_pre_action 17:42:48 INFO - Running main action method: create_virtualenv 17:42:48 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:48 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 17:42:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:42:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:48 INFO - Using real prefix '/usr' 17:42:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:49 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:51 INFO - Installing pip.................done. 17:42:51 INFO - Return code: 0 17:42:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:42:51 INFO - Reading from file tmpfile_stdout 17:42:51 INFO - Output received: 17:42:51 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) 17:42:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:51 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')]} 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:51 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')]} 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:51 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:51 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 17:42:51 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 17:42:51 INFO - Using env: {'DISPLAY': ':0', 17:42:51 INFO - 'HOME': '/home/cltbld', 17:42:51 INFO - 'LANG': 'en_US.UTF-8', 17:42:51 INFO - 'LANGUAGE': 'en_US:en', 17:42:51 INFO - 'LOGNAME': 'cltbld', 17:42:51 INFO - 'MAIL': '/var/mail/cltbld', 17:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:51 INFO - 'MOZ_NO_REMOTE': '1', 17:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:51 INFO - 'NO_EM_RESTART': '1', 17:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:51 INFO - 'PWD': '/builds/slave/test', 17:42:51 INFO - 'SHELL': '/bin/bash', 17:42:51 INFO - 'SHLVL': '1', 17:42:51 INFO - 'TERM': 'linux', 17:42:51 INFO - 'TMOUT': '86400', 17:42:51 INFO - 'USER': 'cltbld', 17:42:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:51 INFO - '_': '/tools/buildbot/bin/python'} 17:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:51 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 17:42:51 INFO - Cleaning up... 17:42:51 INFO - Return code: 0 17:42:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:51 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')]} 17:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:51 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')]} 17:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:51 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:51 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 17:42:51 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 17:42:51 INFO - Using env: {'DISPLAY': ':0', 17:42:51 INFO - 'HOME': '/home/cltbld', 17:42:51 INFO - 'LANG': 'en_US.UTF-8', 17:42:51 INFO - 'LANGUAGE': 'en_US:en', 17:42:51 INFO - 'LOGNAME': 'cltbld', 17:42:51 INFO - 'MAIL': '/var/mail/cltbld', 17:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:51 INFO - 'MOZ_NO_REMOTE': '1', 17:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:51 INFO - 'NO_EM_RESTART': '1', 17:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:51 INFO - 'PWD': '/builds/slave/test', 17:42:51 INFO - 'SHELL': '/bin/bash', 17:42:51 INFO - 'SHLVL': '1', 17:42:51 INFO - 'TERM': 'linux', 17:42:51 INFO - 'TMOUT': '86400', 17:42:51 INFO - 'USER': 'cltbld', 17:42:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:51 INFO - '_': '/tools/buildbot/bin/python'} 17:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:51 INFO - Downloading/unpacking psutil>=3.1.1 17:42: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 17:42: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 17:42: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 17:42: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 17:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:52 INFO - Installing collected packages: psutil 17:42:52 INFO - Running setup.py install for psutil 17:42:52 INFO - building 'psutil._psutil_linux' extension 17:42:52 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 17:42:53 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 17:42:53 INFO - building 'psutil._psutil_posix' extension 17:42:53 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 17:42:53 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 17:42:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:53 INFO - Successfully installed psutil 17:42:53 INFO - Cleaning up... 17:42:53 INFO - Return code: 0 17:42:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:53 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:53 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 17:42:53 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 17:42:53 INFO - Using env: {'DISPLAY': ':0', 17:42:53 INFO - 'HOME': '/home/cltbld', 17:42:53 INFO - 'LANG': 'en_US.UTF-8', 17:42:53 INFO - 'LANGUAGE': 'en_US:en', 17:42:53 INFO - 'LOGNAME': 'cltbld', 17:42:53 INFO - 'MAIL': '/var/mail/cltbld', 17:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:53 INFO - 'MOZ_NO_REMOTE': '1', 17:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:53 INFO - 'NO_EM_RESTART': '1', 17:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:53 INFO - 'PWD': '/builds/slave/test', 17:42:53 INFO - 'SHELL': '/bin/bash', 17:42:53 INFO - 'SHLVL': '1', 17:42:53 INFO - 'TERM': 'linux', 17:42:53 INFO - 'TMOUT': '86400', 17:42:53 INFO - 'USER': 'cltbld', 17:42:53 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:53 INFO - '_': '/tools/buildbot/bin/python'} 17:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:53 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 17:42:53 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 17:42:53 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 17:42:53 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 17:42:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:54 INFO - Installing collected packages: mozsystemmonitor 17:42:54 INFO - Running setup.py install for mozsystemmonitor 17:42:54 INFO - Successfully installed mozsystemmonitor 17:42:54 INFO - Cleaning up... 17:42:54 INFO - Return code: 0 17:42:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42:54 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')]} 17:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:54 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')]} 17:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:54 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:54 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 17:42:54 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 17:42:54 INFO - Using env: {'DISPLAY': ':0', 17:42:54 INFO - 'HOME': '/home/cltbld', 17:42:54 INFO - 'LANG': 'en_US.UTF-8', 17:42:54 INFO - 'LANGUAGE': 'en_US:en', 17:42:54 INFO - 'LOGNAME': 'cltbld', 17:42:54 INFO - 'MAIL': '/var/mail/cltbld', 17:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:54 INFO - 'MOZ_NO_REMOTE': '1', 17:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:54 INFO - 'NO_EM_RESTART': '1', 17:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:54 INFO - 'PWD': '/builds/slave/test', 17:42:54 INFO - 'SHELL': '/bin/bash', 17:42:54 INFO - 'SHLVL': '1', 17:42:54 INFO - 'TERM': 'linux', 17:42:54 INFO - 'TMOUT': '86400', 17:42:54 INFO - 'USER': 'cltbld', 17:42:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:54 INFO - '_': '/tools/buildbot/bin/python'} 17:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:55 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 17:42:55 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 17:42:55 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 17:42:55 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 17:42:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42:56 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 17:42:56 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 17:42:56 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 17:42:56 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 17:42:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:56 INFO - warning: no files found matching '*.txt' 17:42:56 INFO - no previously-included directories found matching 'build' 17:42:56 INFO - no previously-included directories found matching 'dist' 17:42:56 INFO - no previously-included directories found matching '.git*' 17:42:56 INFO - Installing collected packages: jsonschema, functools32 17:42:56 INFO - Running setup.py install for functools32 17:42:56 INFO - warning: no files found matching '*.txt' 17:42:56 INFO - no previously-included directories found matching 'build' 17:42:56 INFO - no previously-included directories found matching 'dist' 17:42:56 INFO - no previously-included directories found matching '.git*' 17:42:56 INFO - Successfully installed jsonschema functools32 17:42:56 INFO - Cleaning up... 17:42:56 INFO - Return code: 0 17:42:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42:56 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')]} 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:56 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')]} 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:56 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:56 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 17:42:56 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 17:42:56 INFO - Using env: {'DISPLAY': ':0', 17:42:56 INFO - 'HOME': '/home/cltbld', 17:42:56 INFO - 'LANG': 'en_US.UTF-8', 17:42:56 INFO - 'LANGUAGE': 'en_US:en', 17:42:56 INFO - 'LOGNAME': 'cltbld', 17:42:56 INFO - 'MAIL': '/var/mail/cltbld', 17:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:56 INFO - 'MOZ_NO_REMOTE': '1', 17:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:56 INFO - 'NO_EM_RESTART': '1', 17:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:56 INFO - 'PWD': '/builds/slave/test', 17:42:56 INFO - 'SHELL': '/bin/bash', 17:42:56 INFO - 'SHLVL': '1', 17:42:56 INFO - 'TERM': 'linux', 17:42:56 INFO - 'TMOUT': '86400', 17:42:56 INFO - 'USER': 'cltbld', 17:42:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:56 INFO - '_': '/tools/buildbot/bin/python'} 17:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:56 INFO - Cleaning up... 17:42:56 INFO - Return code: 0 17:42:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42:56 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')]} 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:56 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')]} 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:56 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:56 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 17:42:56 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 17:42:56 INFO - Using env: {'DISPLAY': ':0', 17:42:56 INFO - 'HOME': '/home/cltbld', 17:42:56 INFO - 'LANG': 'en_US.UTF-8', 17:42:56 INFO - 'LANGUAGE': 'en_US:en', 17:42:56 INFO - 'LOGNAME': 'cltbld', 17:42:56 INFO - 'MAIL': '/var/mail/cltbld', 17:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:56 INFO - 'MOZ_NO_REMOTE': '1', 17:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:56 INFO - 'NO_EM_RESTART': '1', 17:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:56 INFO - 'PWD': '/builds/slave/test', 17:42:56 INFO - 'SHELL': '/bin/bash', 17:42:56 INFO - 'SHLVL': '1', 17:42:56 INFO - 'TERM': 'linux', 17:42:56 INFO - 'TMOUT': '86400', 17:42:56 INFO - 'USER': 'cltbld', 17:42:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:56 INFO - '_': '/tools/buildbot/bin/python'} 17:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:42:56 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 17:42:56 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 17:42:56 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 17:42:56 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 17:42:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:42:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:42:58 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 17:42:58 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 17:42:58 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 17:42:58 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 17:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:42:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:42:58 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 17:42:58 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 17:42:58 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 17:42:58 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 17:42:58 INFO - Downloading docopt-0.6.1.tar.gz 17:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:42:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:42:58 INFO - Running setup.py install for blobuploader 17:42:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:42:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:42:58 INFO - Running setup.py install for requests 17:42:59 INFO - Running setup.py install for docopt 17:42:59 INFO - Successfully installed blobuploader requests docopt 17:42:59 INFO - Cleaning up... 17:42:59 INFO - Return code: 0 17:42:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:59 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:42:59 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 17:42:59 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 17:42:59 INFO - Using env: {'DISPLAY': ':0', 17:42:59 INFO - 'HOME': '/home/cltbld', 17:42:59 INFO - 'LANG': 'en_US.UTF-8', 17:42:59 INFO - 'LANGUAGE': 'en_US:en', 17:42:59 INFO - 'LOGNAME': 'cltbld', 17:42:59 INFO - 'MAIL': '/var/mail/cltbld', 17:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:59 INFO - 'MOZ_NO_REMOTE': '1', 17:42:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:42:59 INFO - 'NO_EM_RESTART': '1', 17:42:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:59 INFO - 'PWD': '/builds/slave/test', 17:42:59 INFO - 'SHELL': '/bin/bash', 17:42:59 INFO - 'SHLVL': '1', 17:42:59 INFO - 'TERM': 'linux', 17:42:59 INFO - 'TMOUT': '86400', 17:42:59 INFO - 'USER': 'cltbld', 17:42:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:59 INFO - '_': '/tools/buildbot/bin/python'} 17:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:42:59 INFO - Running setup.py (path:/tmp/pip-PXTO12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:42:59 INFO - Running setup.py (path:/tmp/pip-e8FZpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:42:59 INFO - Running setup.py (path:/tmp/pip-2WUWbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:42:59 INFO - Running setup.py (path:/tmp/pip-8GjFhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:42:59 INFO - Running setup.py (path:/tmp/pip-kyopef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:42:59 INFO - Running setup.py (path:/tmp/pip-SGoFcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:42:59 INFO - Running setup.py (path:/tmp/pip-bsLNGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:42:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:42:59 INFO - Running setup.py (path:/tmp/pip-BNmBdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:00 INFO - Running setup.py (path:/tmp/pip-BYS_kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:00 INFO - Running setup.py (path:/tmp/pip-fTUYGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:00 INFO - Running setup.py (path:/tmp/pip-G8va65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:00 INFO - Running setup.py (path:/tmp/pip-680r_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:00 INFO - Running setup.py (path:/tmp/pip-NDQ7x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:00 INFO - Running setup.py (path:/tmp/pip-3r0NfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:00 INFO - Running setup.py (path:/tmp/pip-x0ebvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:00 INFO - Running setup.py (path:/tmp/pip-WjCfIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:00 INFO - Running setup.py (path:/tmp/pip-9aaSFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:00 INFO - Running setup.py install for manifestparser 17:43:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:00 INFO - Running setup.py install for mozcrash 17:43:00 INFO - Running setup.py install for mozdebug 17:43:00 INFO - Running setup.py install for mozdevice 17:43:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for mozfile 17:43:01 INFO - Running setup.py install for mozhttpd 17:43:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for mozinfo 17:43:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for mozInstall 17:43:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for mozleak 17:43:01 INFO - Running setup.py install for mozlog 17:43:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for moznetwork 17:43:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for mozprocess 17:43:01 INFO - Running setup.py install for mozprofile 17:43:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:01 INFO - Running setup.py install for mozrunner 17:43:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:02 INFO - Running setup.py install for mozscreenshot 17:43:02 INFO - Running setup.py install for moztest 17:43:02 INFO - Running setup.py install for mozversion 17:43:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:02 INFO - Cleaning up... 17:43:02 INFO - Return code: 0 17:43:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:02 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')]} 17:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:02 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')]} 17:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:02 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:43:02 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 17:43:02 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 17:43:02 INFO - Using env: {'DISPLAY': ':0', 17:43:02 INFO - 'HOME': '/home/cltbld', 17:43:02 INFO - 'LANG': 'en_US.UTF-8', 17:43:02 INFO - 'LANGUAGE': 'en_US:en', 17:43:02 INFO - 'LOGNAME': 'cltbld', 17:43:02 INFO - 'MAIL': '/var/mail/cltbld', 17:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:02 INFO - 'MOZ_NO_REMOTE': '1', 17:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:02 INFO - 'NO_EM_RESTART': '1', 17:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:02 INFO - 'PWD': '/builds/slave/test', 17:43:02 INFO - 'SHELL': '/bin/bash', 17:43:02 INFO - 'SHLVL': '1', 17:43:02 INFO - 'TERM': 'linux', 17:43:02 INFO - 'TMOUT': '86400', 17:43:02 INFO - 'USER': 'cltbld', 17:43:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:02 INFO - '_': '/tools/buildbot/bin/python'} 17:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:02 INFO - Running setup.py (path:/tmp/pip-rbHGMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:02 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)) 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:02 INFO - Running setup.py (path:/tmp/pip-ZoPAFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:02 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)) 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:02 INFO - Running setup.py (path:/tmp/pip-A_MAiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:02 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)) 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:02 INFO - Running setup.py (path:/tmp/pip-_lx9VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:02 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)) 17:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:02 INFO - Running setup.py (path:/tmp/pip-BfZZ1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:03 INFO - Running setup.py (path:/tmp/pip-LuNMAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:03 INFO - Running setup.py (path:/tmp/pip-mYQimH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:03 INFO - Running setup.py (path:/tmp/pip-duecf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:03 INFO - Running setup.py (path:/tmp/pip-kut2Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:03 INFO - Running setup.py (path:/tmp/pip-BIo6L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:03 INFO - Running setup.py (path:/tmp/pip-2MXESg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:03 INFO - Running setup.py (path:/tmp/pip-_V1Q9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:03 INFO - Running setup.py (path:/tmp/pip-QODZvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:03 INFO - Running setup.py (path:/tmp/pip-zTvcmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:03 INFO - Running setup.py (path:/tmp/pip-6W4w5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:03 INFO - Running setup.py (path:/tmp/pip-H7YsoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:03 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)) 17:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:03 INFO - Running setup.py (path:/tmp/pip-c5KGzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:03 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)) 17:43:03 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)) 17:43:03 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)) 17:43:03 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)) 17:43:03 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)) 17:43:03 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)) 17:43:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:03 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 17:43:03 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 17:43:03 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 17:43:03 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 17:43:04 INFO - Downloading blessings-1.6.tar.gz 17:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:05 INFO - Installing collected packages: blessings 17:43:05 INFO - Running setup.py install for blessings 17:43:05 INFO - Successfully installed blessings 17:43:05 INFO - Cleaning up... 17:43:05 INFO - Return code: 0 17:43:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:05 INFO - Reading from file tmpfile_stdout 17:43:05 INFO - Current package versions: 17:43:05 INFO - argparse == 1.2.1 17:43:05 INFO - blessings == 1.6 17:43:05 INFO - blobuploader == 1.2.4 17:43:05 INFO - docopt == 0.6.1 17:43:05 INFO - functools32 == 3.2.3-2 17:43:05 INFO - jsonschema == 2.5.1 17:43:05 INFO - manifestparser == 1.1 17:43:05 INFO - mozInstall == 1.12 17:43:05 INFO - mozcrash == 1.0 17:43:05 INFO - mozdebug == 0.1 17:43:05 INFO - mozdevice == 0.51 17:43:05 INFO - mozfile == 1.2 17:43:05 INFO - mozhttpd == 0.7 17:43:05 INFO - mozinfo == 0.10 17:43:05 INFO - mozleak == 0.1 17:43:05 INFO - mozlog == 3.4 17:43:05 INFO - moznetwork == 0.27 17:43:05 INFO - mozprocess == 0.25 17:43:05 INFO - mozprofile == 0.28 17:43:05 INFO - mozrunner == 6.13 17:43:05 INFO - mozscreenshot == 0.1 17:43:05 INFO - mozsystemmonitor == 0.3 17:43:05 INFO - moztest == 0.8 17:43:05 INFO - mozversion == 1.4 17:43:05 INFO - psutil == 3.1.1 17:43:05 INFO - requests == 1.2.3 17:43:05 INFO - wsgiref == 0.1.2 17:43:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43: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')]} 17:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:05 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 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:43:05 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 17:43:05 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 17:43:05 INFO - Using env: {'DISPLAY': ':0', 17:43:05 INFO - 'HOME': '/home/cltbld', 17:43:05 INFO - 'LANG': 'en_US.UTF-8', 17:43:05 INFO - 'LANGUAGE': 'en_US:en', 17:43:05 INFO - 'LOGNAME': 'cltbld', 17:43:05 INFO - 'MAIL': '/var/mail/cltbld', 17:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:05 INFO - 'MOZ_NO_REMOTE': '1', 17:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:05 INFO - 'NO_EM_RESTART': '1', 17:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:05 INFO - 'PWD': '/builds/slave/test', 17:43:05 INFO - 'SHELL': '/bin/bash', 17:43:05 INFO - 'SHLVL': '1', 17:43:05 INFO - 'TERM': 'linux', 17:43:05 INFO - 'TMOUT': '86400', 17:43:05 INFO - 'USER': 'cltbld', 17:43:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:05 INFO - '_': '/tools/buildbot/bin/python'} 17:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 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)) 17:43:05 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:43:05 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 17:43:05 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 17:43:05 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 17:43:05 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 17:43:06 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:43:07 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)) 17:43:07 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)) 17:43:07 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)) 17:43:07 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)) 17:43:07 INFO - Installing collected packages: marionette-driver 17:43:07 INFO - Running setup.py install for marionette-driver 17:43:07 INFO - Successfully installed marionette-driver 17:43:07 INFO - Cleaning up... 17:43:07 INFO - Return code: 0 17:43:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12c63b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1644dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, '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': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', '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 17:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:43:07 INFO - Using env: {'DISPLAY': ':0', 17:43:07 INFO - 'HOME': '/home/cltbld', 17:43:07 INFO - 'LANG': 'en_US.UTF-8', 17:43:07 INFO - 'LANGUAGE': 'en_US:en', 17:43:07 INFO - 'LOGNAME': 'cltbld', 17:43:07 INFO - 'MAIL': '/var/mail/cltbld', 17:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:07 INFO - 'MOZ_NO_REMOTE': '1', 17:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:07 INFO - 'NO_EM_RESTART': '1', 17:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:07 INFO - 'PWD': '/builds/slave/test', 17:43:07 INFO - 'SHELL': '/bin/bash', 17:43:07 INFO - 'SHLVL': '1', 17:43:07 INFO - 'TERM': 'linux', 17:43:07 INFO - 'TMOUT': '86400', 17:43:07 INFO - 'USER': 'cltbld', 17:43:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:07 INFO - '_': '/tools/buildbot/bin/python'} 17:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:43:07 INFO - Cleaning up... 17:43:07 INFO - Return code: 0 17:43:07 INFO - Running post-action listener: _resource_record_post_action 17:43:07 INFO - Running post-action listener: _start_resource_monitoring 17:43:07 INFO - Starting resource monitoring. 17:43:07 INFO - [mozharness: 2017-06-06 00:43:07.425153Z] Finished create-virtualenv step (success) 17:43:07 INFO - [mozharness: 2017-06-06 00:43:07.425652Z] Running install step. 17:43:07 INFO - Running pre-action listener: _resource_record_pre_action 17:43:07 INFO - Running main action method: install 17:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:07 INFO - Reading from file tmpfile_stdout 17:43:07 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:07 INFO - Reading from file tmpfile_stdout 17:43:07 INFO - Output received: 17:43:07 INFO - Usage: mozinstall [options] installer 17:43:07 INFO - Options: 17:43:07 INFO - -h, --help show this help message and exit 17:43:07 INFO - -d DEST, --destination=DEST 17:43:07 INFO - Directory to install application into. [default: 17:43:07 INFO - "/builds/slave/test"] 17:43:07 INFO - --app=APP Application being installed. [default: firefox] 17:43:07 INFO - mkdir: /builds/slave/test/build/application 17:43:07 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'] 17:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:43:24 INFO - Reading from file tmpfile_stdout 17:43:24 INFO - Output received: 17:43:24 INFO - /builds/slave/test/build/application/firefox/firefox 17:43:24 INFO - Running post-action listener: _resource_record_post_action 17:43:24 INFO - [mozharness: 2017-06-06 00:43:24.658294Z] Finished install step (success) 17:43:24 INFO - [mozharness: 2017-06-06 00:43:24.658574Z] Running setup-mitmproxy step. 17:43:24 INFO - Running pre-action listener: _resource_record_pre_action 17:43:24 INFO - Running main action method: setup_mitmproxy 17:43:24 INFO - Skipping: mitmproxy is not required 17:43:24 INFO - Running post-action listener: _resource_record_post_action 17:43:24 INFO - [mozharness: 2017-06-06 00:43:24.659687Z] Finished setup-mitmproxy step (success) 17:43:24 INFO - [mozharness: 2017-06-06 00:43:24.659906Z] Running run-tests step. 17:43:24 INFO - Running pre-action listener: _resource_record_pre_action 17:43:24 INFO - Running main action method: run_tests 17:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:24 INFO - Python 2.7.3 17:43:24 INFO - Return code: 0 17:43:24 INFO - grabbing minidump binary from tooltool 17:43:24 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')]} 17:43:24 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 0x1641840>, '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 0x1642740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1642bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:24 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 17:43:24 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 17:43:24 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 17:43:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:24 INFO - Return code: 0 17:43:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:43:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:24 INFO - ENV: RUST_BACKTRACE is now 1 17:43:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:43:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:24 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/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 17:43:24 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/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 17:43:24 INFO - Using env: {'DISPLAY': ':0', 17:43:24 INFO - 'HOME': '/home/cltbld', 17:43:24 INFO - 'LANG': 'en_US.UTF-8', 17:43:24 INFO - 'LANGUAGE': 'en_US:en', 17:43:24 INFO - 'LOGNAME': 'cltbld', 17:43:24 INFO - 'MAIL': '/var/mail/cltbld', 17:43:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:24 INFO - 'MOZ_NO_REMOTE': '1', 17:43:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:24 INFO - 'NO_EM_RESTART': '1', 17:43:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:24 INFO - 'PWD': '/builds/slave/test', 17:43:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:24 INFO - 'RUST_BACKTRACE': '1', 17:43:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:43:24 INFO - 'SHELL': '/bin/bash', 17:43:24 INFO - 'SHLVL': '1', 17:43:24 INFO - 'TERM': 'linux', 17:43:24 INFO - 'TMOUT': '86400', 17:43:24 INFO - 'USER': 'cltbld', 17:43:24 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264', 17:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:24 INFO - '_': '/tools/buildbot/bin/python'} 17:43:24 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/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 17:43:24 INFO - mozversion application_buildid: 20170606000420 17:43:24 INFO - mozversion application_changeset: f9acc145b45ee96a24859b93bd5389bde4925c5e 17:43:24 INFO - mozversion application_display_name: Nightly 17:43:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:24 INFO - mozversion application_name: Firefox 17:43:24 INFO - mozversion application_remotingname: firefox 17:43:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:43:24 INFO - mozversion application_vendor: Mozilla 17:43:24 INFO - mozversion application_version: 55.0a1 17:43:24 INFO - mozversion platform_buildid: 20170606000420 17:43:24 INFO - mozversion platform_changeset: f9acc145b45ee96a24859b93bd5389bde4925c5e 17:43:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:43:24 INFO - mozversion platform_version: 55.0a1 17:43:24 INFO - using testdate: 1496709804 17:43:24 INFO - actual date: 1496709804 17:43:24 INFO - starting webserver on 'localhost:54424' 17:43:24 INFO - SUITE-START | Running 2 tests 17:43:24 INFO - TEST-START | dromaeo_css 17:43:24 INFO - operating with platform_type : linux_ 17:43:24 INFO - Initialising browser for dromaeo_css test... 17:43:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54424/getInfo.html -profile /tmp/tmpLHioqI/profile 17:43:24 INFO - TEST-INFO | started process 16184 (/builds/slave/test/build/application/firefox/firefox http://localhost:54424/getInfo.html) 17:44:00 INFO - TEST-INFO | 16184: killed by SIGTERM 17:44:00 INFO - Browser initialized. 17:44:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:00 INFO - TEST-INFO | started process 16391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLHioqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:12 INFO - PID 16391 | RSS: Main: 187379712 17:44:12 INFO - PID 16391 | 17:47:12 INFO - PID 16391 | Cycle 1(1): loaded http://localhost:54424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54424/tests/dromaeo/cssquery-ext.html) 17:47:14 INFO - PID 16391 | RSS: Main: 184209408 17:47:14 INFO - PID 16391 | 17:50:16 INFO - PID 16391 | Cycle 1(1): loaded http://localhost:54424/tests/dromaeo/cssquery-ext.html (next: http://localhost:54424/tests/dromaeo/cssquery-jquery.html) 17:50:16 INFO - PID 16391 | RSS: Main: 189538304 17:50:16 INFO - PID 16391 | 17:53:18 INFO - PID 16391 | Cycle 1(1): loaded http://localhost:54424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54424/tests/dromaeo/cssquery-mootools.html) 17:53:18 INFO - PID 16391 | RSS: Main: 185139200 17:53:18 INFO - PID 16391 | 17:56:20 INFO - PID 16391 | Cycle 1(1): loaded http://localhost:54424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54424/tests/dromaeo/cssquery-prototype.html) 17:56:21 INFO - PID 16391 | RSS: Main: 189464576 17:56:21 INFO - PID 16391 | 17:59:23 INFO - PID 16391 | Cycle 1(1): loaded http://localhost:54424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54424/tests/dromaeo/cssquery-yui.html) 17:59:24 INFO - PID 16391 | RSS: Main: 189956096 17:59:24 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | Cycle 1(1): loaded http://localhost:54424/tests/dromaeo/cssquery-yui.html (next: http://localhost:54424/tests/dromaeo/cssquery-dojo.html) 18:02:26 INFO - PID 16391 | RSS: Main: 189136896 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | __start_tp_report 18:02:26 INFO - PID 16391 | _x_x_mozilla_page_load 18:02:26 INFO - PID 16391 | _x_x_mozilla_page_load_details 18:02:26 INFO - PID 16391 | |i|pagename|runs| 18:02:26 INFO - PID 16391 | |0;dojo.html;3077.3537557113004;3101.286704058065;3114.4238315911557;3121.95317070244;3135.3259049304397;5882.499987501057;5944.435278648532;5980.282366116072;6002.849928751783;6027.186329845469;5878.177055212273;5938.495227905622;5972.970135149319;6029.6382217067;6100.938990610103;5448.536874365684;5534.723263836802;5566.137248726453;5622.184783206432;5640.435956404347;5654.349749778787;5664.716764161775;5675.489205971462;5679.943200568004;5680.11958146488;5401.270828438189;5473;5496.7526461309335;5548.140038294071;5569.749361278732;5542.63972841764;5594.216809646653;5609.635373700738;5617.354004289518;5633.464820842013;5549.0289199389945;5550.583706222009;5553.389127196006;5555.749991250404;5559.749811258463;5913.083472061838;6040.697965101727;6055.424734650245;6064.757409703607;6072.240969878765;6291.905621415683;6323.14637523933;6362.459190968773;6384.585001974857;6428.967855160694;6463.870722585569;6466.547341686084;6468.57954232978;6476.773312934072;6482.902756458657;5977.043673012341;5983.222181116514;5983.311919129269;5998.4601385875485;6007.36922623127;6496;6564.376384243489;6570.638614876228;6626.171728533934;6677.866442671119;6121.544430002081;6133.73253493014;6138.664296166039;6316.652584107826;6375.553711240169;6465.997770345604;6467.450266727286;6488.643124628096;6489.8702025960165;6497.740090396331;6484.25431075423;6505.772297969548;6506.837329066717;6507.609543427409;6514.413702766774;6185.969070154711;6248.812535623939;6302.873942521215;6382.425581697669;6521.445677117404;5236.816711415082;5236.842894713165;5242.239875218148;5252.422233554306;5295.311609490742;4491.438570178728;4493.73037617744;4504.504504504502;4531.56950089741;4538.591526762541;5466.207399926989;5560.777568897199;5654.06707893193;5674.943250567441;5694.402087780806;6242.843928901723;6257.311695713468;6327.58870673414;6337.8732425352155;6358.237011558643;5605.775768969277;5614.550835933115;5668.489835914787;5700.515456186187;5728.742206600713;5570.832875013756;5600.859978500489;5671.51792097668;5683.175939488751;5701;6104.883608894094;6179.474744646665;6258.874822503433;6265.310815810257;6285.74857005733;6490.48076153916;6493.383128602775;6500.5449618526245;6502.219733631994;6506.284308725942;6276.6547839869245;6277.654728989949;6288.465480434214;6292;6292.52806039558;6167.814965550861;6243.282022567281;6263.217097862767;6278.089676996901;6323.588966717149;6370.77702280418;6411.198600174978;6446.323136070832;6451.580647258101;6461.19235095613;6112.50348092447;6197.504199664107;6247.781327653511;6254.718537665725;6257.5932564383165;6216.471599914058;6244.812655620339;6296.401841825019;6302.684865756602;6309.621422714652;6142.9078563820685;6215.533834962486;6215.595986260879;6221.4089661482085;6225.750969961151;6342.587731797418;6344.524160688059;6345.682715864281;6350.523710721622;6365.077063825626;5920.733566989582;6062.969685151546;6096.055111457731;6103.337669688754;6161.784337548164 18:02:26 INFO - PID 16391 | |1;ext.html;730.4959577891254;763.9694412223512;795.5664163031149;1106.5407855739868;1121.3944469986209;36742.81628591857;37569.24861502772;37884.431733523954;37923.24153516928;37946;38513.80743096288;38934;38965;39030;39169;7098.716051357939;7271.600061996602;7292.41660667148;7296.598687072209;7410.925890741104;7213.42292616592;7295.832666773317;7310.34206921377;7310.744123955663;7316.3049510296705;7262.963685181567;7288.3804876585555;7328.743493977712;7346.118465784087;7359.264073592652;7224.67488962998;7229.4939354245225;7258.891116633255;7293.781186564412;7312.817179570553;7191;7196.10048743907;7262.564246145248;7269.12770467542;7289.088863892013;35885.82057089724;35896;35926.64073359285;35976.10059748501;36076.45885311723;3444.2767018926056;3497.3529896969144;3505.018594793462;3509.3332266869215;3520;28163.718362816315;28221.717782822114;28270;28290;28398.858005710044;3552.4493703476;3646.8541258349633;3649.5802982656805;3665.120371110941;3683.4658974448553;144677;145929.27035364756;157857.99999999886;164434;165879;41337.37993930093;41610.37584436236;41729.582704173175;41749.582504175174;41973.160536789095;43372.45805922692;43553.564464355586;43634.56365436305;45067.32399013952;45255.77372113118;15120.54638360851;15410.460633877985;15423.614409639624;15440.382384704486;15493.690126197413;12315.13794034409;12537.122401431994;12552.937235313948;12757.298348590732;12829.166104203383;14041.087329323562;14161.433542658384;14177.929110354382;14178;14205.502807401692;5670.432956704297;5689.43105689436;5724.082432385115;5788.565857560699;5876.618019828783;952.4618590496348;997.1424574865609;997.3666721631816;1002.2783595811004;1011.5094179323022;21477.67783483249;22288;22416.11407488644;22623.547529049327;22896.88551557265;1076.9353838769698;1077.3643550305358;1083.1443159903588;1085.8588383510094;1096.4298564746446;11632.360220187971;11936;12196.926522491198;12688.936555317165;12765.936170319275;187097;190484;208152;210009;210023;53088.73455632774;53237.7338113307;53569.73215133899;53777.462225378025;53899.19151212735;1410.8589141085808;1422.9146251224959;1430.9928450357681;1445.8915581331441;1456.3228098933835;25815.870920646026;27526.724732752416;28125.57811632868;28610.42779144364;28782;34715.652843471245;34750.30499389947;34801.82599086988;34924.12689682778;35062.12344691403;188564;189307;189815;189816;190713;32492.512612311308;32687.67312326846;32737.67262327346;32775;32855.17862053468;40943.590564093975;41446.378304324855;42408.78795606002;43296.78351608348;43595.07644312027;29616.851915740284;30095.247618809706;30479.847600761856;30614.84692576612;32504.674953250164;30285.545716813824;30609.387812243185;30909.227269318446;31207.375852483277;32316.19209519781;34218.65781342254;35494;35511.28977420489;35525.644743552235;36514.26971460609;30038;30214.84892575611;30664.540031899094;30926.0722178335;32305.676943231207;23417.297481075595;24365.756342436347;24551.140710075062;24642.383940400916;24686.876565617058 18:02:26 INFO - PID 16391 | |2;jquery.html;422.58164417226953;428.4066567803592;430.7257581852611;441.3644352132929;449.7099370905766;12678.302693351861;13284.402201900913;20017.399478015646;20829.166833326668;20880;21285.787142128615;22434.88782556085;22497.10011599534;22547.98534065967;22567.435814104654;5790.594658373905;5958;5994.610350327215;6000.879982400349;6005.249343832021;5738.598298119134;5793.884122317551;5794.39158888317;5808.12878068289;5845.473907348338;5728.885422291552;5766.625169363999;5783.82648520543;6148.815535533919;6498.740050397979;6366.681665916685;6377.075324078006;6392.137061496708;6419.614823110628;6421.8073457796345;6252.06219067139;6267.9373206268265;6271.717772700194;6276.215473065867;6293;26596.20211393661;26712.46575068507;26945.191644250703;27050;27090.5936410954;1807.0693592799719;1898.933537326187;1906.5900831321194;1927.7108433734911;1930.3919265431343;17532.64934701299;17830.643387132313;17878.28486860524;17916.193771280323;17950.91024544869;2358.0803486640225;2367.3489790307804;2436.6954130733657;2444.4622183119686;2456.2140115163156;119216;121145;121766.39116804447;122089;123031.38484307521;18830.010047337466;19317.22731090769;20119;20311.898440507703;21039.78960210409;37350.25299493995;37401.625983740356;37434.812825935696;37566;37696;10596.682099537025;10724.195685323632;10804.837927431096;10874.401907894984;10924.781504369868;8762.474251544927;8771.342149338825;8834.690785822466;8840.8673869892;8887.955560222157;10399.168066554657;10618.309809862489;10717.623948456212;10743.946280268548;10961.56153753841;2057.434205593444;2090.7177531033117;2101.4116047506723;2110.6728457089175;2190.8247340212743;925.2366797392178;971.655062452819;976.3117002513211;977.5796407544824;978.9004603983526;17465.563360915825;17543.385981490843;17945.820541794415;18090.728639070425;18336;984.450273790885;1008.848672699101;1012.2256473797551;1037.3723897042332;1045.242199405425;9576.329656924088;9651.613935442503;10052.195824334036;10410.271281010257;10419.322744021614;425737;428091;433789;442446;444723;95940.52029739946;98710;98967;99483;101051;1141.8058929981923;1142.708609304622;1147.0880649883363;1175.9882401175878;1177;15028.6994260112;15565.84434155644;15678.9216053919;16222.783291252967;16718.749218761484;44465;44907.77546112249;45214.32178517391;45727;45926.77036614795;57664.42335576758;58069.41930580809;59266.70366648139;61561.384386155565;62058.37941620526;9936.801263974825;10119.874826286563;10281.943611277924;10399.27205095636;10419.895801041892;16705.66588668244;17411.56471088233;18163.364282250586;18185.909070454563;18269.173082691625;14277.214753188258;14716.632084197552;14922.701545969237;14979.775303370676;15028.549143525712;11962;12573.742625737354;13420.597382078553;13425.798613020617;13799.310034498436;14063.859361406665;14068.718625627635;14077.296135193405;14122.364493597608;14179;9856.753581160528;9920.553575089283;9949.751256218653;10014.499275036365;10046.296759226783;12892.29092399927;13542.59372218835;13743.587692369245;13781.655458613615;13793.724125517232 18:02:26 INFO - PID 16391 | |3;mootools.html;1277.9424925878336;1331.0882045798635;1332.247280286638;1333.8666133386662;1339.1764065099962;10662.573497060119;11029.558817647285;11100.888991110096;11280.548778048878;11413.657590272305;10944.45277736112;11185.776284474327;11206.383648899307;11209.831852522218;11214.887851121486;2318.9652155217686;2367.088670861722;2369.07606033647;2371.6086845670443;2371.8695471749047;2277.4761804784907;2326.150954901466;2329.3477826208687;2331.2423462374795;2351.2476007677465;2231.207921187979;2253.8985745641485;2262.558801033799;2269.818414526842;2284.7715228477105;2153.3755210988793;2177.292379976514;2188.6498160294354;2189.9781002189934;2190.9890450547723;1724.6550689861951;1778.4664600619762;2183.15948359881;2185.89070546472;2188.321620297713;11082.944585277022;11086.2239643225;11093.223474356799;11136.944315278372;11140.33158010514;6031.547633927473;6279.434850863444;6285.968570157165;6289.213848268966;6293.056041593752;3257.3095042249356;3390.55922730046;3439.8624055037767;3443.345764304799;3447.879324223665;1174.448009435564;1180.6458062581191;1205.15036898986;1208.2750349790144;1211.0432758121074;16025.519234422985;16126.516204513884;16168.514944551682;16215.594610134724;16243.431479898147;4938.876528086755;5106.336176297058;5142.640015198975;5228.2941802856885;5264.5525130363585;12236.755264894653;12322;12371.319577423328;12386.81419778704;12399.13206075566;6106.389361063947;6171.074338849208;6201.286852011986;6202.317745048041;6204.441600255998;5662.348829884533;5776.711164441761;5783.190353350535;5797.507211887037;5814.941850581525;4089.9473502927367;4132.132252227006;4171.97914010428;4196.7859489813745;4238.957610423918;1211.121936595961;1215.2404747033104;1229.280870690638;1229.3668760588305;1237.5977807212691;796.2356138107366;826.3224156191865;834.2700137379793;835.5529791561486;869.3132425383876;5980.534768981541;6047.758089676364;6195.690215489208;6228.5017198624;6315.5579109462815;967.5307475874196;999.1307562420595;1003.3829195044995;1013.6452241715488;1018.327903583646;4398.340248962617;4401.046346772092;4607.516210797885;4613.792379342937;4688.226442636927;13919.582412527641;14219.431222751182;14325.64185895361;14448.566543003726;14463.1322120671;13870.237136957363;14438.133711977314;14480.203588802506;14568.344424500923;14647.340869660891;8760.211580957744;8874.645014199488;8958.820823583492;8959.552022398984;8970.058143894928;6323.525735569759;6862.828429289108;6907.514884299699;7021.719131234693;7040.718371265092;12601.18092323996;12722.809157862454;12724.618261452171;12846.807297890726;12865.163764355288;13259.071864969359;13287.13633613812;13324.067315287837;13352.666183345105;13407.396667149807;9428.151466367786;9737.221022318055;9743.610255589698;9745.171660408661;9763.902360976299;10492.580296788348;10519.263651544625;10584.841227381441;10638.41488718128;10659.573617055232;7914.327282180849;8058.516489010678;8150.388720845842;8178.141295163922;8352.749417517483;8428.4942903426;8462.365322600952;8501.914980850359;8660.82678346417;8781;8179.754607361789;8292.709755158781;8315.916840831514;8324.75128730671;8334.874976875473;5734.139879018181;5915.024021036481;5944.405559444021;6065.574589971441;6102.206713127265;5488.396276409512;5759.65442073477;5919.6152250103605;6011.819645410645;6496.70764815575 18:02:26 INFO - PID 16391 | |4;prototype.html;384.84606157537;404.37120277967756;407.7736856044894;409.28988205463514;412.57092623671383;6087.39126087391;6243.687815609224;6248.937510624893;6289.433950944414;6314.052892066193;5998;6089;6089.817305480843;6093.664848433335;6113.6943152842405;4795.256735206049;4807.687500312486;4811.879703007436;4816.133096042711;4819.493953134923;4757.3815403997605;4789.90420191596;4794.280857871312;4807.423109226897;4816.83141090062;4756.167670657638;4767.475577686451;4783.378160839086;4785.755703517076;4796.808127674889;4773.713577185363;4782.187028205196;4792.065547218293;4794.256890182028;4798.7523243956475;4197.160567886435;4199.097194103252;4203.62167404932;4210.473690788652;4214.293211249449;6022.337542870281;6041.486473649745;6056;6067.908981365283;6073.878522429527;5446.91829622556;5456.590755693299;5459.890802183934;5474.890502189974;5492.752826122834;6452.9677351612945;6465.3534646535445;6477.765171015992;6477.935220647781;6488.5133614978595;4537.8411755588395;4566.543345665407;4567.109413664337;4571.2000399929875;4573.565511276423;6490.935090649127;6513.576617519846;6650.966745166292;6758.831029224309;6833.214180369222;4892.486288939681;4930.852074437773;4934.925976110361;4959.752012399365;4985.52637499437;5006.4743201964;5035.144025515671;5052.898942021139;5053.5957123430035;5078.822241221614;5515.4760297771645;5652.095664693629;5656.341519485835;5660.575456840671;5661.858453538694;6525.836854078686;6537.313582073909;6549.16623345464;6562.212534495891;6584.97932820404;1768.1954710606642;1779.884307520007;1784.8929064256185;1785.84812795746;1793.5695433095964;1208.583038851595;1262.532862840755;1285.2802430638872;1287.7295767888847;1291.4124073546514;5729.25519682447;5759.712014399263;5775.595708300379;5776.249087618667;5783.1325301204315;6575.967120164369;6618.437432818168;6647.800565983028;6705.664716764142;6708.932910670928;5654.15187721845;5673.3475650299915;5693.772249110072;5721.828345149652;5757.568182386254;3555.839987200582;3592.4072528033103;3593.1735700788963;3594.856205751793;3595.8022308772747;6493.902591461132;6519.674016299166;6530.412262896267;6532.934670653328;6542.411182993554;6835.418989385858;6854.897176542356;6865.588064716133;6890.8621827563165;6898.586084834926;5967;6459.289478157399;6499.122618446544;6505.796427660993;6517.348265173539;6636.601803891782;6660.900951342974;6673.899891501728;6682.9331706682315;6690.795656781826;6598.274189839018;6607.57050791697;6618.63597502142;6634.303398143318;6652.634105124264;6247.31279559239;6463.289038205888;6480.935190648033;6482.35176482348;6485.837854053686;4627.444706635225;4657.46439159501;4667.743274119956;4668.253079507263;4680.4851466338;6696;6746.311313637171;6763.898541521783;6771.729130834909;6773.593584384953;6545.14913061299;6545.345465453416;6547.574407663486;6559.868802624016;6583.44040756541;6467.676616169078;6484.286728459771;6532.248791389051;6538.117354157128;6554.442872355712;6373.74505019794;6395.552311338161;6435.552000799783;6441.5490915635455;6451.1936007999;6548.017797330439;6574.309697481887;6586.407223349922;6593.769218077345;6595.439387651912;6360.300366959723;6368.503401700504;6387.904181437189;6403.263624683034;6405.327440618668 18:02:26 INFO - PID 16391 | |5;yui.html;807.6648191000735;825.1418524734277;832.3258160889679;841.9831603367933;844.6916875340498;17081.14594270286;17446.127693615334;17565.912170439147;18757.531061723465;20256.29102981392;18833.434996950113;18892.244310227576;19029.238830446764;19082.809171908277;19106.42680719577;961.673031169404;992.290512283717;996.6262651505685;997.9600815967352;1003.3127307794148;959.4147569982305;992.8858181309133;996.7059717383389;996.7657600463886;997.3965750720819;1055.7255113670424;1056.0495554001423;1057.7091299892552;1057.984130238047;1059.5655781129738;1045.3571053801934;1046.4140081554353;1047.6542740895525;1052.2108418685987;1052.3948729480503;766.6435107674957;768.108993567459;768.1205020251781;770.4568279363035;771.9266669666373;16347.591310217222;17042.914785425994;17456.127193640266;17584.912075439668;17663.911680441644;18788.34240801579;19326.80673193264;19346.709799353022;19356.41930742066;19665.410037698894;14519.564413067625;14898.329575169144;15031.774523382159;15065.020773649678;15084.17037062961;3352.4803655433448;3446.6897979181745;3484.1115515543374;3487.8779242726637;3496.230829217568;82816.17183828144;83757;83778.16221837765;84178;84629;13988.160710357208;14603.415863365559;14635.268236588341;14957.70084598302;15087.47193848232;26590.6011409829;26656.466870662865;26711.19866404011;26987;27174.72825271722;7085.645717714094;7320.377767889789;7327.377172940253;7350.485466017328;7839.216078392229;3876.186000939778;3988.6809055275507;3996.900077498086;4004.4593979812935;4004.759714417086;3856.8650097246464;3974.0462289050997;3977.0653896334916;3981.203759248162;4514.210013247669;856.9314454843598;877.1623099939543;878.4377998081233;881.0440671870964;881.8368601808686;673.3367632881608;686.8694947959872;695.9686814093277;699.5872435263118;705.2312978853075;10657.84013239802;11262.605808796652;12251.387430628432;12274.808549776944;12487.625371238877;656.3862788292961;662.7547807311325;664.8304682305981;690.2062627977765;700.4851434195862;4876.975615121973;5237.109691352479;5251.816186433456;5440.6735595864375;5481.808136715196;87127.56436217779;89910;90716.09283907208;90903;91145.54427227822;67807.3219267811;68443.3155668437;69681.65159174171;69706.302936971;77207.22792772112;62322.376776232566;63914;63954.040689389694;64582;64588.35411645917;10643.840342394715;10875.728106797393;11702.94148529286;11725.76548469043;11945;27858.86070569634;28530;28556;29221.123366299045;30261.243468913453;53230.73384633052;54232.72883635556;55288.44711552833;56277.71861140668;56416;16637.750433743746;17163.485095447155;17192.828071719123;17545.210465528828;17795.2204779521;19489.51276218106;19505.804941950966;19656.901715491902;19658.50853728611;19851.702224466935;15851;16032.438864639682;16172;16275.186240688156;16557.66884662324;16263.67472650564;16306.592335191715;16513.422030228885;16557.08936008483;16849.91575042117;16822.327106915585;17455.82544174542;17571.56071098233;17841.821581784534;17883.28466861311;11258.7748245033;11772.17594768358;11820;12180;13143.408546615616;13087.345632718136;13497.545310619089;13976;14002.859971400156;14023 18:02:26 INFO - PID 16391 | __end_tp_report 18:02:26 INFO - PID 16391 | __start_cc_report 18:02:26 INFO - PID 16391 | _x_x_mozilla_cycle_collect,379 18:02:26 INFO - PID 16391 | __end_cc_report 18:02:26 INFO - PID 16391 | __startTimestamp1496710946663__endTimestamp 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | ------- Summary: start ------- 18:02:26 INFO - PID 16391 | Number of tests: 6 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | [#0] dojo.html Cycles:165 Average:5930.27 Median:6133.73 stddev:669.51 (10.9%) stddev-sans-first:633.05 18:02:26 INFO - PID 16391 | Values: 3077.4 3101.3 3114.4 3122.0 3135.3 5882.5 5944.4 5980.3 6002.8 6027.2 5878.2 5938.5 5973.0 6029.6 6100.9 5448.5 5534.7 5566.1 5622.2 5640.4 5654.3 5664.7 5675.5 5679.9 5680.1 5401.3 5473.0 5496.8 5548.1 5569.7 5542.6 5594.2 5609.6 5617.4 5633.5 5549.0 5550.6 5553.4 5555.7 5559.7 5913.1 6040.7 6055.4 6064.8 6072.2 6291.9 6323.1 6362.5 6384.6 6429.0 6463.9 6466.5 6468.6 6476.8 6482.9 5977.0 5983.2 5983.3 5998.5 6007.4 6496.0 6564.4 6570.6 6626.2 6677.9 6121.5 6133.7 6138.7 6316.7 6375.6 6466.0 6467.5 6488.6 6489.9 6497.7 6484.3 6505.8 6506.8 6507.6 6514.4 6186.0 6248.8 6302.9 6382.4 6521.4 5236.8 5236.8 5242.2 5252.4 5295.3 4491.4 4493.7 4504.5 4531.6 4538.6 5466.2 5560.8 5654.1 5674.9 5694.4 6242.8 6257.3 6327.6 6337.9 6358.2 5605.8 5614.6 5668.5 5700.5 5728.7 5570.8 5600.9 5671.5 5683.2 5701.0 6104.9 6179.5 6258.9 6265.3 6285.7 6490.5 6493.4 6500.5 6502.2 6506.3 6276.7 6277.7 6288.5 6292.0 6292.5 6167.8 6243.3 6263.2 6278.1 6323.6 6370.8 6411.2 6446.3 6451.6 6461.2 6112.5 6197.5 6247.8 6254.7 6257.6 6216.5 6244.8 6296.4 6302.7 6309.6 6142.9 6215.5 6215.6 6221.4 6225.8 6342.6 6344.5 6345.7 6350.5 6365.1 5920.7 6063.0 6096.1 6103.3 6161.8 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | [#1] ext.html Cycles:180 Average:34641.39 Median:19079.96 stddev:47383.10 (248.3%) stddev-sans-first:47447.60 18:02:26 INFO - PID 16391 | Values: 730.5 764.0 795.6 1106.5 1121.4 36742.8 37569.2 37884.4 37923.2 37946.0 38513.8 38934.0 38965.0 39030.0 39169.0 7098.7 7271.6 7292.4 7296.6 7410.9 7213.4 7295.8 7310.3 7310.7 7316.3 7263.0 7288.4 7328.7 7346.1 7359.3 7224.7 7229.5 7258.9 7293.8 7312.8 7191.0 7196.1 7262.6 7269.1 7289.1 35885.8 35896.0 35926.6 35976.1 36076.5 3444.3 3497.4 3505.0 3509.3 3520.0 28163.7 28221.7 28270.0 28290.0 28398.9 3552.4 3646.9 3649.6 3665.1 3683.5 144677.0 145929.3 157858.0 164434.0 165879.0 41337.4 41610.4 41729.6 41749.6 41973.2 43372.5 43553.6 43634.6 45067.3 45255.8 15120.5 15410.5 15423.6 15440.4 15493.7 12315.1 12537.1 12552.9 12757.3 12829.2 14041.1 14161.4 14177.9 14178.0 14205.5 5670.4 5689.4 5724.1 5788.6 5876.6 952.5 997.1 997.4 1002.3 1011.5 21477.7 22288.0 22416.1 22623.5 22896.9 1076.9 1077.4 1083.1 1085.9 1096.4 11632.4 11936.0 12196.9 12688.9 12765.9 187097.0 190484.0 208152.0 210009.0 210023.0 53088.7 53237.7 53569.7 53777.5 53899.2 1410.9 1422.9 1431.0 1445.9 1456.3 25815.9 27526.7 28125.6 28610.4 28782.0 34715.7 34750.3 34801.8 34924.1 35062.1 188564.0 189307.0 189815.0 189816.0 190713.0 32492.5 32687.7 32737.7 32775.0 32855.2 40943.6 41446.4 42408.8 43296.8 43595.1 29616.9 30095.2 30479.8 30614.8 32504.7 30285.5 30609.4 30909.2 31207.4 32316.2 34218.7 35494.0 35511.3 35525.6 36514.3 30038.0 30214.8 30664.5 30926.1 32305.7 23417.3 24365.8 24551.1 24642.4 24686.9 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | [#2] jquery.html Cycles:180 Average:30832.31 Median:11570.60 stddev:73098.97 (631.8%) stddev-sans-first:73268.37 18:02:26 INFO - PID 16391 | Values: 422.6 428.4 430.7 441.4 449.7 12678.3 13284.4 20017.4 20829.2 20880.0 21285.8 22434.9 22497.1 22548.0 22567.4 5790.6 5958.0 5994.6 6000.9 6005.2 5738.6 5793.9 5794.4 5808.1 5845.5 5728.9 5766.6 5783.8 6148.8 6498.7 6366.7 6377.1 6392.1 6419.6 6421.8 6252.1 6267.9 6271.7 6276.2 6293.0 26596.2 26712.5 26945.2 27050.0 27090.6 1807.1 1898.9 1906.6 1927.7 1930.4 17532.6 17830.6 17878.3 17916.2 17950.9 2358.1 2367.3 2436.7 2444.5 2456.2 119216.0 121145.0 121766.4 122089.0 123031.4 18830.0 19317.2 20119.0 20311.9 21039.8 37350.3 37401.6 37434.8 37566.0 37696.0 10596.7 10724.2 10804.8 10874.4 10924.8 8762.5 8771.3 8834.7 8840.9 8888.0 10399.2 10618.3 10717.6 10743.9 10961.6 2057.4 2090.7 2101.4 2110.7 2190.8 925.2 971.7 976.3 977.6 978.9 17465.6 17543.4 17945.8 18090.7 18336.0 984.5 1008.8 1012.2 1037.4 1045.2 9576.3 9651.6 10052.2 10410.3 10419.3 425737.0 428091.0 433789.0 442446.0 444723.0 95940.5 98710.0 98967.0 99483.0 101051.0 1141.8 1142.7 1147.1 1176.0 1177.0 15028.7 15565.8 15678.9 16222.8 16718.7 44465.0 44907.8 45214.3 45727.0 45926.8 57664.4 58069.4 59266.7 61561.4 62058.4 9936.8 10119.9 10281.9 10399.3 10419.9 16705.7 17411.6 18163.4 18185.9 18269.2 14277.2 14716.6 14922.7 14979.8 15028.5 11962.0 12573.7 13420.6 13425.8 13799.3 14063.9 14068.7 14077.3 14122.4 14179.0 9856.8 9920.6 9949.8 10014.5 10046.3 12892.3 13542.6 13743.6 13781.7 13793.7 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | [#3] mootools.html Cycles:180 Average:6882.47 Median:2370.34 stddev:4411.80 (186.1%) stddev-sans-first:4404.07 18:02:26 INFO - PID 16391 | Values: 1277.9 1331.1 1332.2 1333.9 1339.2 10662.6 11029.6 11100.9 11280.5 11413.7 10944.5 11185.8 11206.4 11209.8 11214.9 2319.0 2367.1 2369.1 2371.6 2371.9 2277.5 2326.2 2329.3 2331.2 2351.2 2231.2 2253.9 2262.6 2269.8 2284.8 2153.4 2177.3 2188.6 2190.0 2191.0 1724.7 1778.5 2183.2 2185.9 2188.3 11082.9 11086.2 11093.2 11136.9 11140.3 6031.5 6279.4 6286.0 6289.2 6293.1 3257.3 3390.6 3439.9 3443.3 3447.9 1174.4 1180.6 1205.2 1208.3 1211.0 16025.5 16126.5 16168.5 16215.6 16243.4 4938.9 5106.3 5142.6 5228.3 5264.6 12236.8 12322.0 12371.3 12386.8 12399.1 6106.4 6171.1 6201.3 6202.3 6204.4 5662.3 5776.7 5783.2 5797.5 5814.9 4089.9 4132.1 4172.0 4196.8 4239.0 1211.1 1215.2 1229.3 1229.4 1237.6 796.2 826.3 834.3 835.6 869.3 5980.5 6047.8 6195.7 6228.5 6315.6 967.5 999.1 1003.4 1013.6 1018.3 4398.3 4401.0 4607.5 4613.8 4688.2 13919.6 14219.4 14325.6 14448.6 14463.1 13870.2 14438.1 14480.2 14568.3 14647.3 8760.2 8874.6 8958.8 8959.6 8970.1 6323.5 6862.8 6907.5 7021.7 7040.7 12601.2 12722.8 12724.6 12846.8 12865.2 13259.1 13287.1 13324.1 13352.7 13407.4 9428.2 9737.2 9743.6 9745.2 9763.9 10492.6 10519.3 10584.8 10638.4 10659.6 7914.3 8058.5 8150.4 8178.1 8352.7 8428.5 8462.4 8501.9 8660.8 8781.0 8179.8 8292.7 8315.9 8324.8 8334.9 5734.1 5915.0 5944.4 6065.6 6102.2 5488.4 5759.7 5919.6 6011.8 6496.7 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | [#4] prototype.html Cycles:180 Average:5432.98 Median:6070.89 stddev:1557.20 (25.7%) stddev-sans-first:1514.77 18:02:26 INFO - PID 16391 | Values: 384.8 404.4 407.8 409.3 412.6 6087.4 6243.7 6248.9 6289.4 6314.1 5998.0 6089.0 6089.8 6093.7 6113.7 4795.3 4807.7 4811.9 4816.1 4819.5 4757.4 4789.9 4794.3 4807.4 4816.8 4756.2 4767.5 4783.4 4785.8 4796.8 4773.7 4782.2 4792.1 4794.3 4798.8 4197.2 4199.1 4203.6 4210.5 4214.3 6022.3 6041.5 6056.0 6067.9 6073.9 5446.9 5456.6 5459.9 5474.9 5492.8 6453.0 6465.4 6477.8 6477.9 6488.5 4537.8 4566.5 4567.1 4571.2 4573.6 6490.9 6513.6 6651.0 6758.8 6833.2 4892.5 4930.9 4934.9 4959.8 4985.5 5006.5 5035.1 5052.9 5053.6 5078.8 5515.5 5652.1 5656.3 5660.6 5661.9 6525.8 6537.3 6549.2 6562.2 6585.0 1768.2 1779.9 1784.9 1785.8 1793.6 1208.6 1262.5 1285.3 1287.7 1291.4 5729.3 5759.7 5775.6 5776.2 5783.1 6576.0 6618.4 6647.8 6705.7 6708.9 5654.2 5673.3 5693.8 5721.8 5757.6 3555.8 3592.4 3593.2 3594.9 3595.8 6493.9 6519.7 6530.4 6532.9 6542.4 6835.4 6854.9 6865.6 6890.9 6898.6 5967.0 6459.3 6499.1 6505.8 6517.3 6636.6 6660.9 6673.9 6682.9 6690.8 6598.3 6607.6 6618.6 6634.3 6652.6 6247.3 6463.3 6480.9 6482.4 6485.8 4627.4 4657.5 4667.7 4668.3 4680.5 6696.0 6746.3 6763.9 6771.7 6773.6 6545.1 6545.3 6547.6 6559.9 6583.4 6467.7 6484.3 6532.2 6538.1 6554.4 6373.7 6395.6 6435.6 6441.5 6451.2 6548.0 6574.3 6586.4 6593.8 6595.4 6360.3 6368.5 6387.9 6403.3 6405.3 18:02:26 INFO - PID 16391 | 18:02:26 INFO - PID 16391 | [#5] yui.html Cycles:180 Average:19177.71 Median:27516.79 stddev:23402.88 (85.0%) stddev-sans-first:23427.88 18:02:26 INFO - PID 16391 | Values: 807.7 825.1 832.3 842.0 844.7 17081.1 17446.1 17565.9 18757.5 20256.3 18833.4 18892.2 19029.2 19082.8 19106.4 961.7 992.3 996.6 998.0 1003.3 959.4 992.9 996.7 996.8 997.4 1055.7 1056.0 1057.7 1058.0 1059.6 1045.4 1046.4 1047.7 1052.2 1052.4 766.6 768.1 768.1 770.5 771.9 16347.6 17042.9 17456.1 17584.9 17663.9 18788.3 19326.8 19346.7 19356.4 19665.4 14519.6 14898.3 15031.8 15065.0 15084.2 3352.5 3446.7 3484.1 3487.9 3496.2 82816.2 83757.0 83778.2 84178.0 84629.0 13988.2 14603.4 14635.3 14957.7 15087.5 26590.6 26656.5 26711.2 26987.0 27174.7 7085.6 7320.4 7327.4 7350.5 7839.2 3876.2 3988.7 3996.9 4004.5 4004.8 3856.9 3974.0 3977.1 3981.2 4514.2 856.9 877.2 878.4 881.0 881.8 673.3 686.9 696.0 699.6 705.2 10657.8 11262.6 12251.4 12274.8 12487.6 656.4 662.8 664.8 690.2 700.5 4877.0 5237.1 5251.8 5440.7 5481.8 87127.6 89910.0 90716.1 90903.0 91145.5 67807.3 68443.3 69681.7 69706.3 77207.2 62322.4 63914.0 63954.0 64582.0 64588.4 10643.8 10875.7 11702.9 11725.8 11945.0 27858.9 28530.0 28556.0 29221.1 30261.2 53230.7 54232.7 55288.4 56277.7 56416.0 16637.8 17163.5 17192.8 17545.2 17795.2 19489.5 19505.8 19656.9 19658.5 19851.7 15851.0 16032.4 16172.0 16275.2 16557.7 16263.7 16306.6 16513.4 16557.1 16849.9 16822.3 17455.8 17571.6 17841.8 17883.3 11258.8 11772.2 11820.0 12180.0 13143.4 13087.3 13497.5 13976.0 14002.9 14023.0 18:02:26 INFO - PID 16391 | -------- Summary: end -------- 18:02:26 INFO - PID 16391 | 18:02:27 INFO - TEST-INFO | 16391: exit 0 18:02:27 INFO - TEST-OK | dromaeo_css | took 1142600ms 18:02:27 INFO - TEST-START | kraken 18:02:27 INFO - operating with platform_type : linux_ 18:02:27 INFO - Initialising browser for kraken test... 18:02:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54424/getInfo.html -profile /tmp/tmpzpOsun/profile 18:02:27 INFO - TEST-INFO | started process 16788 (/builds/slave/test/build/application/firefox/firefox http://localhost:54424/getInfo.html) 18:03:02 INFO - TEST-INFO | 16788: killed by SIGTERM 18:03:02 INFO - Browser initialized. 18:03:02 INFO - Running cycle 1/1 for kraken test... 18:03:02 INFO - TEST-INFO | started process 16994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzpOsun/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:14 INFO - PID 16994 | RSS: Main: 187334656 18:03:14 INFO - PID 16994 | 18:03:17 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54424/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:18 INFO - PID 16994 | RSS: Main: 191311872 18:03:18 INFO - PID 16994 | 18:03:20 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54424/tests/kraken/driver.html?testName=audio-dft) 18:03:21 INFO - PID 16994 | RSS: Main: 189865984 18:03:21 INFO - PID 16994 | 18:03:24 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54424/tests/kraken/driver.html?testName=audio-fft) 18:03:24 INFO - PID 16994 | RSS: Main: 185221120 18:03:24 INFO - PID 16994 | 18:03:26 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54424/tests/kraken/driver.html?testName=audio-oscillator) 18:03:27 INFO - PID 16994 | RSS: Main: 186175488 18:03:27 INFO - PID 16994 | 18:03:29 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:30 INFO - PID 16994 | RSS: Main: 186109952 18:03:30 INFO - PID 16994 | 18:03:33 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54424/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:33 INFO - PID 16994 | RSS: Main: 187691008 18:03:33 INFO - PID 16994 | 18:03:37 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54424/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:38 INFO - PID 16994 | RSS: Main: 187052032 18:03:38 INFO - PID 16994 | 18:03:40 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54424/tests/kraken/driver.html?testName=json-parse-financial) 18:03:41 INFO - PID 16994 | RSS: Main: 187559936 18:03:41 INFO - PID 16994 | 18:03:43 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:43 INFO - PID 16994 | RSS: Main: 187731968 18:03:43 INFO - PID 16994 | 18:03:45 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:46 INFO - PID 16994 | RSS: Main: 187359232 18:03:46 INFO - PID 16994 | 18:03:48 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:49 INFO - PID 16994 | RSS: Main: 187838464 18:03:49 INFO - PID 16994 | 18:03:51 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:52 INFO - PID 16994 | RSS: Main: 187629568 18:03:52 INFO - PID 16994 | 18:03:55 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:03:56 INFO - PID 16994 | RSS: Main: 187817984 18:03:56 INFO - PID 16994 | 18:03:57 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:54424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54424/tests/kraken/driver.html?testName=ai-astar) 18:03:58 INFO - PID 16994 | RSS: Main: 188796928 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | __start_tp_report 18:03:58 INFO - PID 16994 | _x_x_mozilla_page_load 18:03:58 INFO - PID 16994 | _x_x_mozilla_page_load_details 18:03:58 INFO - PID 16994 | |i|pagename|runs| 18:03:58 INFO - PID 16994 | |0;ai-astar;103;111;112;111;110;112;110;112;110;111 18:03:58 INFO - PID 16994 | |1;audio-beat-detection;153;120;122;182;122;124;126;131;149;127 18:03:58 INFO - PID 16994 | |2;audio-dft;163;164;163;163;164;163;168;170;166;163 18:03:58 INFO - PID 16994 | |3;audio-fft;74;75;74;112;76;74;78;74;103;74 18:03:58 INFO - PID 16994 | |4;audio-oscillator;82;81;99;82;82;81;96;83;83;100 18:03:58 INFO - PID 16994 | |5;imaging-gaussian-blur;114;116;113;113;115;114;114;114;114;114 18:03:58 INFO - PID 16994 | |6;imaging-darkroom;152;151;151;149;151;151;150;151;150;150 18:03:58 INFO - PID 16994 | |7;imaging-desaturate;94;94;94;94;94;95;94;94;95;94 18:03:58 INFO - PID 16994 | |8;json-parse-financial;55;55;54;54;55;57;60;55;54;55 18:03:58 INFO - PID 16994 | |9;json-stringify-tinderbox;59;55;55;55;55;55;55;55;56;55 18:03:58 INFO - PID 16994 | |10;stanford-crypto-aes;87;89;87;88;96;87;86;95;106;92 18:03:58 INFO - PID 16994 | |11;stanford-crypto-ccm;130;130;140;131;133;129;131;132;128;134 18:03:58 INFO - PID 16994 | |12;stanford-crypto-pbkdf2;183;184;193;207;194;188;205;196;197;192 18:03:58 INFO - PID 16994 | |13;stanford-crypto-sha256-iterative;73;73;74;72;71;76;72;71;71;70 18:03:58 INFO - PID 16994 | __end_tp_report 18:03:58 INFO - PID 16994 | __start_cc_report 18:03:58 INFO - PID 16994 | _x_x_mozilla_cycle_collect,993 18:03:58 INFO - PID 16994 | __end_cc_report 18:03:58 INFO - PID 16994 | __startTimestamp1496711038090__endTimestamp 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | ------- Summary: start ------- 18:03:58 INFO - PID 16994 | Number of tests: 14 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 18:03:58 INFO - PID 16994 | Values: 103.0 111.0 112.0 111.0 110.0 112.0 110.0 112.0 110.0 111.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:129.00 stddev:19.92 (15.4%) stddev-sans-first:20.11 18:03:58 INFO - PID 16994 | Values: 153.0 120.0 122.0 182.0 122.0 124.0 126.0 131.0 149.0 127.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.50 (1.5%) stddev-sans-first:2.57 18:03:58 INFO - PID 16994 | Values: 163.0 164.0 163.0 163.0 164.0 163.0 168.0 170.0 166.0 163.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.00 stddev:13.98 (18.9%) stddev-sans-first:14.57 18:03:58 INFO - PID 16994 | Values: 74.0 75.0 74.0 112.0 76.0 74.0 78.0 74.0 103.0 74.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:82.50 stddev:7.98 (9.7%) stddev-sans-first:8.26 18:03:58 INFO - PID 16994 | Values: 82.0 81.0 99.0 82.0 82.0 81.0 96.0 83.0 83.0 100.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 18:03:58 INFO - PID 16994 | Values: 114.0 116.0 113.0 113.0 115.0 114.0 114.0 114.0 114.0 114.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.73 18:03:58 INFO - PID 16994 | Values: 152.0 151.0 151.0 149.0 151.0 151.0 150.0 151.0 150.0 150.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:03:58 INFO - PID 16994 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.84 (3.3%) stddev-sans-first:1.94 18:03:58 INFO - PID 16994 | Values: 55.0 55.0 54.0 54.0 55.0 57.0 60.0 55.0 54.0 55.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:1.27 (2.3%) stddev-sans-first:0.33 18:03:58 INFO - PID 16994 | Values: 59.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 55.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:88.50 stddev:6.25 (7.1%) stddev-sans-first:6.44 18:03:58 INFO - PID 16994 | Values: 87.0 89.0 87.0 88.0 96.0 87.0 86.0 95.0 106.0 92.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#11] stanford-crypto-ccm Cycles:10 Average:131.80 Median:131.50 stddev:3.39 (2.6%) stddev-sans-first:3.54 18:03:58 INFO - PID 16994 | Values: 130.0 130.0 140.0 131.0 133.0 129.0 131.0 132.0 128.0 134.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:195.00 stddev:7.92 (4.1%) stddev-sans-first:7.36 18:03:58 INFO - PID 16994 | Values: 183.0 184.0 193.0 207.0 194.0 188.0 205.0 196.0 197.0 192.0 18:03:58 INFO - PID 16994 | 18:03:58 INFO - PID 16994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.77 (2.4%) stddev-sans-first:1.86 18:03:58 INFO - PID 16994 | Values: 73.0 73.0 74.0 72.0 71.0 76.0 72.0 71.0 71.0 70.0 18:03:58 INFO - PID 16994 | -------- Summary: end -------- 18:03:58 INFO - PID 16994 | 18:03:59 INFO - TEST-INFO | 16994: exit 0 18:03:59 INFO - TEST-OK | kraken | took 91724ms 18:03:59 INFO - SUITE-END | took 1234s 18:03:59 INFO - Completed test suite (00:20:34) 18:03:59 INFO - javascript benchmark 18:03:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7755.44777883682, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.3537557113004, 3101.286704058065, 3114.4238315911557, 3121.95317070244, 3135.3259049304397, 5882.499987501057, 5944.435278648532, 5980.282366116072, 6002.849928751783, 6027.186329845469, 5878.177055212273, 5938.495227905622, 5972.970135149319, 6029.6382217067, 6100.938990610103, 5448.536874365684, 5534.723263836802, 5566.137248726453, 5622.184783206432, 5640.435956404347, 5654.349749778787, 5664.716764161775, 5675.489205971462, 5679.943200568004, 5680.11958146488, 5401.270828438189, 5473.0, 5496.7526461309335, 5548.140038294071, 5569.749361278732, 5542.63972841764, 5594.216809646653, 5609.635373700738, 5617.354004289518, 5633.464820842013, 5549.0289199389945, 5550.583706222009, 5553.389127196006, 5555.749991250404, 5559.749811258463, 5913.083472061838, 6040.697965101727, 6055.424734650245, 6064.757409703607, 6072.240969878765, 6291.905621415683, 6323.14637523933, 6362.459190968773, 6384.585001974857, 6428.967855160694, 6463.870722585569, 6466.547341686084, 6468.57954232978, 6476.773312934072, 6482.902756458657, 5977.043673012341, 5983.222181116514, 5983.311919129269, 5998.4601385875485, 6007.36922623127, 6496.0, 6564.376384243489, 6570.638614876228, 6626.171728533934, 6677.866442671119, 6121.544430002081, 6133.73253493014, 6138.664296166039, 6316.652584107826, 6375.553711240169, 6465.997770345604, 6467.450266727286, 6488.643124628096, 6489.8702025960165, 6497.740090396331, 6484.25431075423, 6505.772297969548, 6506.837329066717, 6507.609543427409, 6514.413702766774, 6185.969070154711, 6248.812535623939, 6302.873942521215, 6382.425581697669, 6521.445677117404, 5236.816711415082, 5236.842894713165, 5242.239875218148, 5252.422233554306, 5295.311609490742, 4491.438570178728, 4493.73037617744, 4504.504504504502, 4531.56950089741, 4538.591526762541, 5466.207399926989, 5560.777568897199, 5654.06707893193, 5674.943250567441, 5694.402087780806, 6242.843928901723, 6257.311695713468, 6327.58870673414, 6337.8732425352155, 6358.237011558643, 5605.775768969277, 5614.550835933115, 5668.489835914787, 5700.515456186187, 5728.742206600713, 5570.832875013756, 5600.859978500489, 5671.51792097668, 5683.175939488751, 5701.0, 6104.883608894094, 6179.474744646665, 6258.874822503433, 6265.310815810257, 6285.74857005733, 6490.48076153916, 6493.383128602775, 6500.5449618526245, 6502.219733631994, 6506.284308725942, 6276.6547839869245, 6277.654728989949, 6288.465480434214, 6292.0, 6292.52806039558, 6167.814965550861, 6243.282022567281, 6263.217097862767, 6278.089676996901, 6323.588966717149, 6370.77702280418, 6411.198600174978, 6446.323136070832, 6451.580647258101, 6461.19235095613, 6112.50348092447, 6197.504199664107, 6247.781327653511, 6254.718537665725, 6257.5932564383165, 6216.471599914058, 6244.812655620339, 6296.401841825019, 6302.684865756602, 6309.621422714652, 6142.9078563820685, 6215.533834962486, 6215.595986260879, 6221.4089661482085, 6225.750969961151, 6342.587731797418, 6344.524160688059, 6345.682715864281, 6350.523710721622, 6365.077063825626, 5920.733566989582, 6062.969685151546, 6096.055111457731, 6103.337669688754, 6161.784337548164], "value": 5882.172952838295, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.4959577891254, 763.9694412223512, 795.5664163031149, 1106.5407855739868, 1121.3944469986209, 36742.81628591857, 37569.24861502772, 37884.431733523954, 37923.24153516928, 37946.0, 38513.80743096288, 38934.0, 38965.0, 39030.0, 39169.0, 7098.716051357939, 7271.600061996602, 7292.41660667148, 7296.598687072209, 7410.925890741104, 7213.42292616592, 7295.832666773317, 7310.34206921377, 7310.744123955663, 7316.3049510296705, 7262.963685181567, 7288.3804876585555, 7328.743493977712, 7346.118465784087, 7359.264073592652, 7224.67488962998, 7229.4939354245225, 7258.891116633255, 7293.781186564412, 7312.817179570553, 7191.0, 7196.10048743907, 7262.564246145248, 7269.12770467542, 7289.088863892013, 35885.82057089724, 35896.0, 35926.64073359285, 35976.10059748501, 36076.45885311723, 3444.2767018926056, 3497.3529896969144, 3505.018594793462, 3509.3332266869215, 3520.0, 28163.718362816315, 28221.717782822114, 28270.0, 28290.0, 28398.858005710044, 3552.4493703476, 3646.8541258349633, 3649.5802982656805, 3665.120371110941, 3683.4658974448553, 144677.0, 145929.27035364756, 157857.99999999886, 164434.0, 165879.0, 41337.37993930093, 41610.37584436236, 41729.582704173175, 41749.582504175174, 41973.160536789095, 43372.45805922692, 43553.564464355586, 43634.56365436305, 45067.32399013952, 45255.77372113118, 15120.54638360851, 15410.460633877985, 15423.614409639624, 15440.382384704486, 15493.690126197413, 12315.13794034409, 12537.122401431994, 12552.937235313948, 12757.298348590732, 12829.166104203383, 14041.087329323562, 14161.433542658384, 14177.929110354382, 14178.0, 14205.502807401692, 5670.432956704297, 5689.43105689436, 5724.082432385115, 5788.565857560699, 5876.618019828783, 952.4618590496348, 997.1424574865609, 997.3666721631816, 1002.2783595811004, 1011.5094179323022, 21477.67783483249, 22288.0, 22416.11407488644, 22623.547529049327, 22896.88551557265, 1076.9353838769698, 1077.3643550305358, 1083.1443159903588, 1085.8588383510094, 1096.4298564746446, 11632.360220187971, 11936.0, 12196.926522491198, 12688.936555317165, 12765.936170319275, 187097.0, 190484.0, 208152.0, 210009.0, 210023.0, 53088.73455632774, 53237.7338113307, 53569.73215133899, 53777.462225378025, 53899.19151212735, 1410.8589141085808, 1422.9146251224959, 1430.9928450357681, 1445.8915581331441, 1456.3228098933835, 25815.870920646026, 27526.724732752416, 28125.57811632868, 28610.42779144364, 28782.0, 34715.652843471245, 34750.30499389947, 34801.82599086988, 34924.12689682778, 35062.12344691403, 188564.0, 189307.0, 189815.0, 189816.0, 190713.0, 32492.512612311308, 32687.67312326846, 32737.67262327346, 32775.0, 32855.17862053468, 40943.590564093975, 41446.378304324855, 42408.78795606002, 43296.78351608348, 43595.07644312027, 29616.851915740284, 30095.247618809706, 30479.847600761856, 30614.84692576612, 32504.674953250164, 30285.545716813824, 30609.387812243185, 30909.227269318446, 31207.375852483277, 32316.19209519781, 34218.65781342254, 35494.0, 35511.28977420489, 35525.644743552235, 36514.26971460609, 30038.0, 30214.84892575611, 30664.540031899094, 30926.0722178335, 32305.676943231207, 23417.297481075595, 24365.756342436347, 24551.140710075062, 24642.383940400916, 24686.876565617058], "value": 16328.01259514218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.58164417226953, 428.4066567803592, 430.7257581852611, 441.3644352132929, 449.7099370905766, 12678.302693351861, 13284.402201900913, 20017.399478015646, 20829.166833326668, 20880.0, 21285.787142128615, 22434.88782556085, 22497.10011599534, 22547.98534065967, 22567.435814104654, 5790.594658373905, 5958.0, 5994.610350327215, 6000.879982400349, 6005.249343832021, 5738.598298119134, 5793.884122317551, 5794.39158888317, 5808.12878068289, 5845.473907348338, 5728.885422291552, 5766.625169363999, 5783.82648520543, 6148.815535533919, 6498.740050397979, 6366.681665916685, 6377.075324078006, 6392.137061496708, 6419.614823110628, 6421.8073457796345, 6252.06219067139, 6267.9373206268265, 6271.717772700194, 6276.215473065867, 6293.0, 26596.20211393661, 26712.46575068507, 26945.191644250703, 27050.0, 27090.5936410954, 1807.0693592799719, 1898.933537326187, 1906.5900831321194, 1927.7108433734911, 1930.3919265431343, 17532.64934701299, 17830.643387132313, 17878.28486860524, 17916.193771280323, 17950.91024544869, 2358.0803486640225, 2367.3489790307804, 2436.6954130733657, 2444.4622183119686, 2456.2140115163156, 119216.0, 121145.0, 121766.39116804447, 122089.0, 123031.38484307521, 18830.010047337466, 19317.22731090769, 20119.0, 20311.898440507703, 21039.78960210409, 37350.25299493995, 37401.625983740356, 37434.812825935696, 37566.0, 37696.0, 10596.682099537025, 10724.195685323632, 10804.837927431096, 10874.401907894984, 10924.781504369868, 8762.474251544927, 8771.342149338825, 8834.690785822466, 8840.8673869892, 8887.955560222157, 10399.168066554657, 10618.309809862489, 10717.623948456212, 10743.946280268548, 10961.56153753841, 2057.434205593444, 2090.7177531033117, 2101.4116047506723, 2110.6728457089175, 2190.8247340212743, 925.2366797392178, 971.655062452819, 976.3117002513211, 977.5796407544824, 978.9004603983526, 17465.563360915825, 17543.385981490843, 17945.820541794415, 18090.728639070425, 18336.0, 984.450273790885, 1008.848672699101, 1012.2256473797551, 1037.3723897042332, 1045.242199405425, 9576.329656924088, 9651.613935442503, 10052.195824334036, 10410.271281010257, 10419.322744021614, 425737.0, 428091.0, 433789.0, 442446.0, 444723.0, 95940.52029739946, 98710.0, 98967.0, 99483.0, 101051.0, 1141.8058929981923, 1142.708609304622, 1147.0880649883363, 1175.9882401175878, 1177.0, 15028.6994260112, 15565.84434155644, 15678.9216053919, 16222.783291252967, 16718.749218761484, 44465.0, 44907.77546112249, 45214.32178517391, 45727.0, 45926.77036614795, 57664.42335576758, 58069.41930580809, 59266.70366648139, 61561.384386155565, 62058.37941620526, 9936.801263974825, 10119.874826286563, 10281.943611277924, 10399.27205095636, 10419.895801041892, 16705.66588668244, 17411.56471088233, 18163.364282250586, 18185.909070454563, 18269.173082691625, 14277.214753188258, 14716.632084197552, 14922.701545969237, 14979.775303370676, 15028.549143525712, 11962.0, 12573.742625737354, 13420.597382078553, 13425.798613020617, 13799.310034498436, 14063.859361406665, 14068.718625627635, 14077.296135193405, 14122.364493597608, 14179.0, 9856.753581160528, 9920.553575089283, 9949.751256218653, 10014.499275036365, 10046.296759226783, 12892.29092399927, 13542.59372218835, 13743.587692369245, 13781.655458613615, 13793.724125517232], "value": 10781.838978734975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.9424925878336, 1331.0882045798635, 1332.247280286638, 1333.8666133386662, 1339.1764065099962, 10662.573497060119, 11029.558817647285, 11100.888991110096, 11280.548778048878, 11413.657590272305, 10944.45277736112, 11185.776284474327, 11206.383648899307, 11209.831852522218, 11214.887851121486, 2318.9652155217686, 2367.088670861722, 2369.07606033647, 2371.6086845670443, 2371.8695471749047, 2277.4761804784907, 2326.150954901466, 2329.3477826208687, 2331.2423462374795, 2351.2476007677465, 2231.207921187979, 2253.8985745641485, 2262.558801033799, 2269.818414526842, 2284.7715228477105, 2153.3755210988793, 2177.292379976514, 2188.6498160294354, 2189.9781002189934, 2190.9890450547723, 1724.6550689861951, 1778.4664600619762, 2183.15948359881, 2185.89070546472, 2188.321620297713, 11082.944585277022, 11086.2239643225, 11093.223474356799, 11136.944315278372, 11140.33158010514, 6031.547633927473, 6279.434850863444, 6285.968570157165, 6289.213848268966, 6293.056041593752, 3257.3095042249356, 3390.55922730046, 3439.8624055037767, 3443.345764304799, 3447.879324223665, 1174.448009435564, 1180.6458062581191, 1205.15036898986, 1208.2750349790144, 1211.0432758121074, 16025.519234422985, 16126.516204513884, 16168.514944551682, 16215.594610134724, 16243.431479898147, 4938.876528086755, 5106.336176297058, 5142.640015198975, 5228.2941802856885, 5264.5525130363585, 12236.755264894653, 12322.0, 12371.319577423328, 12386.81419778704, 12399.13206075566, 6106.389361063947, 6171.074338849208, 6201.286852011986, 6202.317745048041, 6204.441600255998, 5662.348829884533, 5776.711164441761, 5783.190353350535, 5797.507211887037, 5814.941850581525, 4089.9473502927367, 4132.132252227006, 4171.97914010428, 4196.7859489813745, 4238.957610423918, 1211.121936595961, 1215.2404747033104, 1229.280870690638, 1229.3668760588305, 1237.5977807212691, 796.2356138107366, 826.3224156191865, 834.2700137379793, 835.5529791561486, 869.3132425383876, 5980.534768981541, 6047.758089676364, 6195.690215489208, 6228.5017198624, 6315.5579109462815, 967.5307475874196, 999.1307562420595, 1003.3829195044995, 1013.6452241715488, 1018.327903583646, 4398.340248962617, 4401.046346772092, 4607.516210797885, 4613.792379342937, 4688.226442636927, 13919.582412527641, 14219.431222751182, 14325.64185895361, 14448.566543003726, 14463.1322120671, 13870.237136957363, 14438.133711977314, 14480.203588802506, 14568.344424500923, 14647.340869660891, 8760.211580957744, 8874.645014199488, 8958.820823583492, 8959.552022398984, 8970.058143894928, 6323.525735569759, 6862.828429289108, 6907.514884299699, 7021.719131234693, 7040.718371265092, 12601.18092323996, 12722.809157862454, 12724.618261452171, 12846.807297890726, 12865.163764355288, 13259.071864969359, 13287.13633613812, 13324.067315287837, 13352.666183345105, 13407.396667149807, 9428.151466367786, 9737.221022318055, 9743.610255589698, 9745.171660408661, 9763.902360976299, 10492.580296788348, 10519.263651544625, 10584.841227381441, 10638.41488718128, 10659.573617055232, 7914.327282180849, 8058.516489010678, 8150.388720845842, 8178.141295163922, 8352.749417517483, 8428.4942903426, 8462.365322600952, 8501.914980850359, 8660.82678346417, 8781.0, 8179.754607361789, 8292.709755158781, 8315.916840831514, 8324.75128730671, 8334.874976875473, 5734.139879018181, 5915.024021036481, 5944.405559444021, 6065.574589971441, 6102.206713127265, 5488.396276409512, 5759.65442073477, 5919.6152250103605, 6011.819645410645, 6496.70764815575], "value": 5169.477068848088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.84606157537, 404.37120277967756, 407.7736856044894, 409.28988205463514, 412.57092623671383, 6087.39126087391, 6243.687815609224, 6248.937510624893, 6289.433950944414, 6314.052892066193, 5998.0, 6089.0, 6089.817305480843, 6093.664848433335, 6113.6943152842405, 4795.256735206049, 4807.687500312486, 4811.879703007436, 4816.133096042711, 4819.493953134923, 4757.3815403997605, 4789.90420191596, 4794.280857871312, 4807.423109226897, 4816.83141090062, 4756.167670657638, 4767.475577686451, 4783.378160839086, 4785.755703517076, 4796.808127674889, 4773.713577185363, 4782.187028205196, 4792.065547218293, 4794.256890182028, 4798.7523243956475, 4197.160567886435, 4199.097194103252, 4203.62167404932, 4210.473690788652, 4214.293211249449, 6022.337542870281, 6041.486473649745, 6056.0, 6067.908981365283, 6073.878522429527, 5446.91829622556, 5456.590755693299, 5459.890802183934, 5474.890502189974, 5492.752826122834, 6452.9677351612945, 6465.3534646535445, 6477.765171015992, 6477.935220647781, 6488.5133614978595, 4537.8411755588395, 4566.543345665407, 4567.109413664337, 4571.2000399929875, 4573.565511276423, 6490.935090649127, 6513.576617519846, 6650.966745166292, 6758.831029224309, 6833.214180369222, 4892.486288939681, 4930.852074437773, 4934.925976110361, 4959.752012399365, 4985.52637499437, 5006.4743201964, 5035.144025515671, 5052.898942021139, 5053.5957123430035, 5078.822241221614, 5515.4760297771645, 5652.095664693629, 5656.341519485835, 5660.575456840671, 5661.858453538694, 6525.836854078686, 6537.313582073909, 6549.16623345464, 6562.212534495891, 6584.97932820404, 1768.1954710606642, 1779.884307520007, 1784.8929064256185, 1785.84812795746, 1793.5695433095964, 1208.583038851595, 1262.532862840755, 1285.2802430638872, 1287.7295767888847, 1291.4124073546514, 5729.25519682447, 5759.712014399263, 5775.595708300379, 5776.249087618667, 5783.1325301204315, 6575.967120164369, 6618.437432818168, 6647.800565983028, 6705.664716764142, 6708.932910670928, 5654.15187721845, 5673.3475650299915, 5693.772249110072, 5721.828345149652, 5757.568182386254, 3555.839987200582, 3592.4072528033103, 3593.1735700788963, 3594.856205751793, 3595.8022308772747, 6493.902591461132, 6519.674016299166, 6530.412262896267, 6532.934670653328, 6542.411182993554, 6835.418989385858, 6854.897176542356, 6865.588064716133, 6890.8621827563165, 6898.586084834926, 5967.0, 6459.289478157399, 6499.122618446544, 6505.796427660993, 6517.348265173539, 6636.601803891782, 6660.900951342974, 6673.899891501728, 6682.9331706682315, 6690.795656781826, 6598.274189839018, 6607.57050791697, 6618.63597502142, 6634.303398143318, 6652.634105124264, 6247.31279559239, 6463.289038205888, 6480.935190648033, 6482.35176482348, 6485.837854053686, 4627.444706635225, 4657.46439159501, 4667.743274119956, 4668.253079507263, 4680.4851466338, 6696.0, 6746.311313637171, 6763.898541521783, 6771.729130834909, 6773.593584384953, 6545.14913061299, 6545.345465453416, 6547.574407663486, 6559.868802624016, 6583.44040756541, 6467.676616169078, 6484.286728459771, 6532.248791389051, 6538.117354157128, 6554.442872355712, 6373.74505019794, 6395.552311338161, 6435.552000799783, 6441.5490915635455, 6451.1936007999, 6548.017797330439, 6574.309697481887, 6586.407223349922, 6593.769218077345, 6595.439387651912, 6360.300366959723, 6368.503401700504, 6387.904181437189, 6403.263624683034, 6405.327440618668], "value": 4956.265769778286, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.6648191000735, 825.1418524734277, 832.3258160889679, 841.9831603367933, 844.6916875340498, 17081.14594270286, 17446.127693615334, 17565.912170439147, 18757.531061723465, 20256.29102981392, 18833.434996950113, 18892.244310227576, 19029.238830446764, 19082.809171908277, 19106.42680719577, 961.673031169404, 992.290512283717, 996.6262651505685, 997.9600815967352, 1003.3127307794148, 959.4147569982305, 992.8858181309133, 996.7059717383389, 996.7657600463886, 997.3965750720819, 1055.7255113670424, 1056.0495554001423, 1057.7091299892552, 1057.984130238047, 1059.5655781129738, 1045.3571053801934, 1046.4140081554353, 1047.6542740895525, 1052.2108418685987, 1052.3948729480503, 766.6435107674957, 768.108993567459, 768.1205020251781, 770.4568279363035, 771.9266669666373, 16347.591310217222, 17042.914785425994, 17456.127193640266, 17584.912075439668, 17663.911680441644, 18788.34240801579, 19326.80673193264, 19346.709799353022, 19356.41930742066, 19665.410037698894, 14519.564413067625, 14898.329575169144, 15031.774523382159, 15065.020773649678, 15084.17037062961, 3352.4803655433448, 3446.6897979181745, 3484.1115515543374, 3487.8779242726637, 3496.230829217568, 82816.17183828144, 83757.0, 83778.16221837765, 84178.0, 84629.0, 13988.160710357208, 14603.415863365559, 14635.268236588341, 14957.70084598302, 15087.47193848232, 26590.6011409829, 26656.466870662865, 26711.19866404011, 26987.0, 27174.72825271722, 7085.645717714094, 7320.377767889789, 7327.377172940253, 7350.485466017328, 7839.216078392229, 3876.186000939778, 3988.6809055275507, 3996.900077498086, 4004.4593979812935, 4004.759714417086, 3856.8650097246464, 3974.0462289050997, 3977.0653896334916, 3981.203759248162, 4514.210013247669, 856.9314454843598, 877.1623099939543, 878.4377998081233, 881.0440671870964, 881.8368601808686, 673.3367632881608, 686.8694947959872, 695.9686814093277, 699.5872435263118, 705.2312978853075, 10657.84013239802, 11262.605808796652, 12251.387430628432, 12274.808549776944, 12487.625371238877, 656.3862788292961, 662.7547807311325, 664.8304682305981, 690.2062627977765, 700.4851434195862, 4876.975615121973, 5237.109691352479, 5251.816186433456, 5440.6735595864375, 5481.808136715196, 87127.56436217779, 89910.0, 90716.09283907208, 90903.0, 91145.54427227822, 67807.3219267811, 68443.3155668437, 69681.65159174171, 69706.302936971, 77207.22792772112, 62322.376776232566, 63914.0, 63954.040689389694, 64582.0, 64588.35411645917, 10643.840342394715, 10875.728106797393, 11702.94148529286, 11725.76548469043, 11945.0, 27858.86070569634, 28530.0, 28556.0, 29221.123366299045, 30261.243468913453, 53230.73384633052, 54232.72883635556, 55288.44711552833, 56277.71861140668, 56416.0, 16637.750433743746, 17163.485095447155, 17192.828071719123, 17545.210465528828, 17795.2204779521, 19489.51276218106, 19505.804941950966, 19656.901715491902, 19658.50853728611, 19851.702224466935, 15851.0, 16032.438864639682, 16172.0, 16275.186240688156, 16557.66884662324, 16263.67472650564, 16306.592335191715, 16513.422030228885, 16557.08936008483, 16849.91575042117, 16822.327106915585, 17455.82544174542, 17571.56071098233, 17841.821581784534, 17883.28466861311, 11258.7748245033, 11772.17594768358, 11820.0, 12180.0, 13143.408546615616, 13087.345632718136, 13497.545310619089, 13976.0, 14002.859971400156, 14023.0], "value": 8200.622165336983, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 111.0, 110.0, 112.0, 110.0, 112.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 122.0, 182.0, 122.0, 124.0, 126.0, 131.0, 149.0, 127.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 163.0, 164.0, 163.0, 168.0, 170.0, 166.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 112.0, 76.0, 74.0, 78.0, 74.0, 103.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 99.0, 82.0, 82.0, 81.0, 96.0, 83.0, 83.0, 100.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 149.0, 151.0, 151.0, 150.0, 151.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 57.0, 60.0, 55.0, 54.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 87.0, 88.0, 96.0, 87.0, 86.0, 95.0, 106.0, 92.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 140.0, 131.0, 133.0, 129.0, 131.0, 132.0, 128.0, 134.0], "value": 131.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 193.0, 207.0, 194.0, 188.0, 205.0, 196.0, 197.0, 192.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 72.0, 71.0, 76.0, 72.0, 71.0, 71.0, 70.0], "value": 72.3, "unit": "score"}]}]} 18:03:59 INFO - Return code: 0 18:03:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:03:59 INFO - # TBPL SUCCESS # 18:03:59 INFO - Running post-action listener: _resource_record_post_action 18:03:59 INFO - [mozharness: 2017-06-06 01:03:59.471316Z] Finished run-tests step (success) 18:03:59 INFO - Running post-run listener: _resource_record_post_run 18:03:59 INFO - Total resource usage - Wall time: 1251s; CPU: 13.0%; Read bytes: 8192; Write bytes: 426385408; Read time: 192; Write time: 299244 18:03:59 INFO - TinderboxPrint: CPU usage
12.6% 18:03:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 18:03:59 INFO - TinderboxPrint: I/O write bytes / time
426,385,408 / 299,244 18:03:59 INFO - TinderboxPrint: CPU idle
8,720.4 (87.3%) 18:03:59 INFO - TinderboxPrint: CPU user
1,209.9 (12.1%) 18:03:59 INFO - TinderboxPrint: Swap in / out
0 / 0 18:03:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102322176; Read time: 0; Write time: 64004 18:03:59 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:03:59 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324063232; Read time: 180; Write time: 235240 18:04:00 INFO - Running post-run listener: _upload_blobber_files 18:04:00 INFO - Blob upload gear active. 18:04:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:00 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 18:04:00 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'] 18:04:00 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 18:04:00 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:01 INFO - (blobuploader) - INFO - Done attempting. 18:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:07 INFO - (blobuploader) - INFO - Done attempting. 18:04:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:08 INFO - (blobuploader) - INFO - Done attempting. 18:04:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:09 INFO - (blobuploader) - INFO - Done attempting. 18:04:09 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:09 INFO - Return code: 0 18:04:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1b81e1d3159430c4d8f0cf0576fd06f6c642c7473a971572d174582bc08898c08dab8e36838a3b53deb99e87462a4307abfa6717eb41a0aa88db16d2e323dc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191cd7fd44a87a2414cc3aa33e85f8d273f480453106ecb20ffbf6e27a16446ba04d6c4d66d0a2a5fb29f3ac284d81bcf5637b0a1e547ba0b6f29003865445e9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a273e1a8b55f88299c91e9a431c1a1466e426b66814556a0c9f8cb41adcd70366940e680816a0eb364d860d426b23646b3b73fc1d034e382d81baa7902247d0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91671d24381edffc206b53663aa328976f00276eea18951aea1d4b362882cac4a24f26936bc66a6b7015efe8c5efb3dbd398f40c4506bb401518adbd3f283fc1"} 18:04:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:09 INFO - Contents: 18:04:09 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1b81e1d3159430c4d8f0cf0576fd06f6c642c7473a971572d174582bc08898c08dab8e36838a3b53deb99e87462a4307abfa6717eb41a0aa88db16d2e323dc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191cd7fd44a87a2414cc3aa33e85f8d273f480453106ecb20ffbf6e27a16446ba04d6c4d66d0a2a5fb29f3ac284d81bcf5637b0a1e547ba0b6f29003865445e9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a273e1a8b55f88299c91e9a431c1a1466e426b66814556a0c9f8cb41adcd70366940e680816a0eb364d860d426b23646b3b73fc1d034e382d81baa7902247d0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91671d24381edffc206b53663aa328976f00276eea18951aea1d4b362882cac4a24f26936bc66a6b7015efe8c5efb3dbd398f40c4506bb401518adbd3f283fc1"} 18:04:09 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:09 INFO - Copying logs to upload dir... 18:04:09 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.764838 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-05 18:04:09.023752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 18:04:09.026872) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264 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/c1b81e1d3159430c4d8f0cf0576fd06f6c642c7473a971572d174582bc08898c08dab8e36838a3b53deb99e87462a4307abfa6717eb41a0aa88db16d2e323dc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191cd7fd44a87a2414cc3aa33e85f8d273f480453106ecb20ffbf6e27a16446ba04d6c4d66d0a2a5fb29f3ac284d81bcf5637b0a1e547ba0b6f29003865445e9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a273e1a8b55f88299c91e9a431c1a1466e426b66814556a0c9f8cb41adcd70366940e680816a0eb364d860d426b23646b3b73fc1d034e382d81baa7902247d0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91671d24381edffc206b53663aa328976f00276eea18951aea1d4b362882cac4a24f26936bc66a6b7015efe8c5efb3dbd398f40c4506bb401518adbd3f283fc1"} build_url:https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/bn8o9jc7QS2EpBADKi7ycg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1b81e1d3159430c4d8f0cf0576fd06f6c642c7473a971572d174582bc08898c08dab8e36838a3b53deb99e87462a4307abfa6717eb41a0aa88db16d2e323dc1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191cd7fd44a87a2414cc3aa33e85f8d273f480453106ecb20ffbf6e27a16446ba04d6c4d66d0a2a5fb29f3ac284d81bcf5637b0a1e547ba0b6f29003865445e9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a273e1a8b55f88299c91e9a431c1a1466e426b66814556a0c9f8cb41adcd70366940e680816a0eb364d860d426b23646b3b73fc1d034e382d81baa7902247d0e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91671d24381edffc206b53663aa328976f00276eea18951aea1d4b362882cac4a24f26936bc66a6b7015efe8c5efb3dbd398f40c4506bb401518adbd3f283fc1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 18:04:09.058267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 18:04:09.058612) ========= 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=17051fcd5208b27b50bedfeb000001dd-1496708321.56242-2120998264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 18:04:09.140260) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 18:04:09.143660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 18:04:09.144045) ========= ========= Total master_lag: 0.18 =========