builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1500219545.94 results: success (0) revision: c1185e615e55949151f20c66d55b0e7e62034adb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:05.938980) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:05.939892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:05.940193) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:05.972870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:05.973137) ========= 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=03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 08:39:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.1M=0s 2017-07-16 08:39:06 (45.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:06.137878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:06.138175) ========= 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=03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021518 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:06.191093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 08:39:06.191411) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c1185e615e55949151f20c66d55b0e7e62034adb --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 c1185e615e55949151f20c66d55b0e7e62034adb --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=03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 08:39:06,495 truncating revision to first 12 chars 2017-07-16 08:39:06,496 Setting DEBUG logging. 2017-07-16 08:39:06,496 attempt 1/10 2017-07-16 08:39:06,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c1185e615e55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 08:39:07,570 unpacking tar archive at: mozilla-central-c1185e615e55/testing/mozharness/ program finished with exit code 0 elapsedTime=1.389891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 08:39:07.593601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:07.593919) ========= script_repo_revision: c1185e615e55949151f20c66d55b0e7e62034adb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:07.594296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:07.594612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 08:39:07.606771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-07-16 08:39:07.607090) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:39:08 INFO - MultiFileLogger online at 20170716 08:39:08 in /builds/slave/test 08:39:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:39:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:39:08 INFO - {'append_to_log': False, 08:39:08 INFO - 'base_work_dir': '/builds/slave/test', 08:39:08 INFO - 'blob_upload_branch': 'Firefox', 08:39:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:39:08 INFO - 'branch': 'Firefox', 08:39:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:08 INFO - 'code_coverage': False, 08:39:08 INFO - 'config_files': ('talos/linux_config.py',), 08:39:08 INFO - 'default_actions': ('clobber', 08:39:08 INFO - 'read-buildbot-config', 08:39:08 INFO - 'download-and-extract', 08:39:08 INFO - 'populate-webroot', 08:39:08 INFO - 'create-virtualenv', 08:39:08 INFO - 'install', 08:39:08 INFO - 'setup-mitmproxy', 08:39:08 INFO - 'run-tests'), 08:39:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:08 INFO - 'disable_ccov_upload': False, 08:39:08 INFO - 'download_minidump_stackwalk': True, 08:39:08 INFO - 'download_symbols': 'ondemand', 08:39:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:08 INFO - 'gecko_profile': False, 08:39:08 INFO - 'gecko_profile_interval': 0, 08:39:08 INFO - 'installer_path': 'installer.exe', 08:39:08 INFO - 'log_level': 'info', 08:39:08 INFO - 'log_name': 'talos', 08:39:08 INFO - 'log_to_console': True, 08:39:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:39:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:39:08 INFO - 'opt_config_files': (), 08:39:08 INFO - 'pip_index': False, 08:39:08 INFO - 'suite': 'dromaeojs-e10s', 08:39:08 INFO - 'system_bits': '32', 08:39:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:08 INFO - 'title': 'talos-linux64-ix-047', 08:39:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:08 INFO - 'use_talos_json': True, 08:39:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:39:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:08 INFO - 'work_dir': 'build'} 08:39:08 INFO - [mozharness: 2017-07-16 15:39:08.011615Z] Running clobber step. 08:39:08 INFO - Running pre-action listener: _resource_record_pre_action 08:39:08 INFO - Running main action method: clobber 08:39:08 INFO - rmtree: /builds/slave/test/build 08:39:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:39:09 INFO - Running post-action listener: _resource_record_post_action 08:39:09 INFO - [mozharness: 2017-07-16 15:39:09.562594Z] Finished clobber step (success) 08:39:09 INFO - [mozharness: 2017-07-16 15:39:09.562696Z] Running read-buildbot-config step. 08:39:09 INFO - Running pre-action listener: _resource_record_pre_action 08:39:09 INFO - Running main action method: read_buildbot_config 08:39:09 INFO - Using buildbot properties: 08:39:09 INFO - { 08:39:09 INFO - "project": "", 08:39:09 INFO - "product": "firefox", 08:39:09 INFO - "who": "archaeopteryx@coole-files.de", 08:39:09 INFO - "installer_path": "public/build/target.tar.bz2", 08:39:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:39:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:39:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 08:39:09 INFO - "stage_platform": "linux64-pgo", 08:39:09 INFO - "basedir": "/builds/slave/test", 08:39:09 INFO - "buildnumber": 65, 08:39:09 INFO - "platform": "ubuntu64_hw", 08:39:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:39:09 INFO - "slavebuilddir": "test", 08:39:09 INFO - "taskId": "aGXxJYDFQlq2Rk8yirsv5A", 08:39:09 INFO - "branch": "mozilla-central", 08:39:09 INFO - "script_repo_revision": "production", 08:39:09 INFO - "revision": "c1185e615e55949151f20c66d55b0e7e62034adb", 08:39:09 INFO - "slavename": "talos-linux64-ix-047", 08:39:09 INFO - "repo_path": "mozilla-central" 08:39:09 INFO - } 08:39:09 INFO - Finding installer, test and symbols from parent task. 08:39:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aGXxJYDFQlq2Rk8yirsv5A'}, attempt #1 08:39:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aGXxJYDFQlq2Rk8yirsv5A'}, attempt #1 08:39:10 INFO - Task dependencies: G6r6NslBSzWKbo6uodt9KQ 08:39:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ'}, attempt #1 08:39:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2 08:39:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/test_packages.json 08:39:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.crashreporter-symbols.zip 08:39:10 INFO - Running post-action listener: _resource_record_post_action 08:39:10 INFO - [mozharness: 2017-07-16 15:39:10.907179Z] Finished read-buildbot-config step (success) 08:39:10 INFO - [mozharness: 2017-07-16 15:39:10.907400Z] Running download-and-extract step. 08:39:10 INFO - Running pre-action listener: _resource_record_pre_action 08:39:10 INFO - Running main action method: download_and_extract 08:39:10 INFO - mkdir: /builds/slave/test/build/tests 08:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:10 INFO - trying https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.test_packages.json 08:39:10 INFO - Downloading https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:39:11 INFO - Downloaded 989 bytes. 08:39:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:39:11 INFO - Using the following test package requirements: 08:39:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:39:11 INFO - u'common': [u'target.common.tests.zip'], 08:39:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:39:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:39:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:39:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:39:11 INFO - u'mozbase': [u'target.common.tests.zip'], 08:39:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:39:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:39:11 INFO - u'web-platform': [u'target.common.tests.zip', 08:39:11 INFO - u'target.web-platform.tests.tar.gz'], 08:39:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:39:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:39:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.common.tests.zip 08:39:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:39:11 INFO - Fetch https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.common.tests.zip into memory 08:39:13 INFO - Content-Length response header: 73366162 08:39:13 INFO - Bytes received: 73366162 08:39:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:39:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.common.tests.zip 08:39:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:39:24 INFO - Fetch https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.common.tests.zip into memory 08:39:25 INFO - Content-Length response header: 73366162 08:39:25 INFO - Bytes received: 73366162 08:39:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.talos.tests.zip 08:39:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:39:40 INFO - Fetch https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.talos.tests.zip into memory 08:39:40 INFO - Content-Length response header: 14495033 08:39:40 INFO - Bytes received: 14495033 08:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:40 INFO - trying https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2 08:39:40 INFO - Downloading https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:39:42 INFO - Downloaded 62574941 bytes. 08:39:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2 08:39:42 INFO - mkdir: /builds/slave/test/properties 08:39:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:39:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:39:42 INFO - Contents: 08:39:42 INFO - build_url:https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2 08:39:42 INFO - Running post-action listener: _resource_record_post_action 08:39:42 INFO - Running post-action listener: set_extra_try_arguments 08:39:42 INFO - [mozharness: 2017-07-16 15:39:42.121736Z] Finished download-and-extract step (success) 08:39:42 INFO - [mozharness: 2017-07-16 15:39:42.121832Z] Running populate-webroot step. 08:39:42 INFO - Running pre-action listener: _resource_record_pre_action 08:39:42 INFO - Running main action method: populate_webroot 08:39:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:42 INFO - '--tppagecycles', 08:39:42 INFO - '7'], 08:39:42 INFO - 'tests': ['tsvgm']}}, 08:39:42 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:39:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:39:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:39:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['damp', 'tps']}, 08:39:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'tests': ['damp', 'tps']}, 08:39:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['dromaeo_dom']}, 08:39:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:39:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:39:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:39:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['a11yr', 08:39:42 INFO - 'ts_paint', 08:39:42 INFO - 'tpaint', 08:39:42 INFO - 'sessionrestore', 08:39:42 INFO - 'sessionrestore_no_auto_restore', 08:39:42 INFO - 'tabpaint']}, 08:39:42 INFO - 'other-e10s': {'tests': ['a11yr', 08:39:42 INFO - 'ts_paint', 08:39:42 INFO - 'tpaint', 08:39:42 INFO - 'sessionrestore', 08:39:42 INFO - 'sessionrestore_many_windows', 08:39:42 INFO - 'sessionrestore_no_auto_restore', 08:39:42 INFO - 'tabpaint']}, 08:39:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:39:42 INFO - 'ts_paint', 08:39:42 INFO - 'tpaint', 08:39:42 INFO - 'sessionrestore', 08:39:42 INFO - 'sessionrestore_many_windows', 08:39:42 INFO - 'sessionrestore_no_auto_restore', 08:39:42 INFO - 'tabpaint']}, 08:39:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:39:42 INFO - 'ts_paint', 08:39:42 INFO - 'tpaint', 08:39:42 INFO - 'sessionrestore', 08:39:42 INFO - 'sessionrestore_many_windows', 08:39:42 INFO - 'sessionrestore_no_auto_restore', 08:39:42 INFO - 'tabpaint']}, 08:39:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['a11yr', 08:39:42 INFO - 'ts_paint', 08:39:42 INFO - 'tpaint', 08:39:42 INFO - 'sessionrestore', 08:39:42 INFO - 'sessionrestore_no_auto_restore', 08:39:42 INFO - 'tabpaint']}, 08:39:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['a11yr', 08:39:42 INFO - 'ts_paint', 08:39:42 INFO - 'tpaint', 08:39:42 INFO - 'sessionrestore', 08:39:42 INFO - 'sessionrestore_no_auto_restore', 08:39:42 INFO - 'tabpaint']}, 08:39:42 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:39:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:39:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:39:42 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:39:42 INFO - 'talos_options': ['--mitmproxy', 08:39:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:39:42 INFO - '--firstNonBlankPaint'], 08:39:42 INFO - 'tests': ['quantum_pageload_google', 08:39:42 INFO - 'quantum_pageload_youtube', 08:39:42 INFO - 'quantum_pageload_amazon', 08:39:42 INFO - 'quantum_pageload_facebook']}, 08:39:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['tsvgx', 08:39:42 INFO - 'tsvgr_opacity', 08:39:42 INFO - 'tart', 08:39:42 INFO - 'tscrollx', 08:39:42 INFO - 'cart', 08:39:42 INFO - 'tsvg_static']}, 08:39:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:39:42 INFO - 'tsvgr_opacity', 08:39:42 INFO - 'tart', 08:39:42 INFO - 'tscrollx', 08:39:42 INFO - 'cart', 08:39:42 INFO - 'tsvg_static']}, 08:39:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'talos_options': ['--disable-e10s'], 08:39:42 INFO - 'tests': ['tp5o']}, 08:39:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:39:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'talos_options': ['--disable-e10s', 08:39:42 INFO - '--xperf_path', 08:39:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:42 INFO - 'tests': ['tp5n']}, 08:39:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:39:42 INFO - 'talos_options': ['--xperf_path', 08:39:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:42 INFO - 'tests': ['tp5n']}}, 08:39:42 INFO - 'talos.zip': {'path': '', 08:39:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:42 INFO - Running post-action listener: _resource_record_post_action 08:39:42 INFO - [mozharness: 2017-07-16 15:39:42.137033Z] Finished populate-webroot step (success) 08:39:42 INFO - [mozharness: 2017-07-16 15:39:42.137123Z] Running create-virtualenv step. 08:39:42 INFO - Running pre-action listener: _resource_record_pre_action 08:39:42 INFO - Running main action method: create_virtualenv 08:39:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:39:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:39:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:39:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:39:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:42 INFO - Using real prefix '/usr' 08:39:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:44 INFO - Installing pip.................done. 08:39:44 INFO - Return code: 0 08:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:39:44 INFO - Reading from file tmpfile_stdout 08:39:44 INFO - Output received: 08:39:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:39:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:44 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:39:44 INFO - Using env: {'DISPLAY': ':0', 08:39:44 INFO - 'HOME': '/home/cltbld', 08:39:44 INFO - 'LANG': 'en_US.UTF-8', 08:39:44 INFO - 'LANGUAGE': 'en_US:en', 08:39:44 INFO - 'LOGNAME': 'cltbld', 08:39:44 INFO - 'MAIL': '/var/mail/cltbld', 08:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:44 INFO - 'MOZ_NO_REMOTE': '1', 08:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:44 INFO - 'NO_EM_RESTART': '1', 08:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:44 INFO - 'PWD': '/builds/slave/test', 08:39:44 INFO - 'SHELL': '/bin/bash', 08:39:44 INFO - 'SHLVL': '1', 08:39:44 INFO - 'TERM': 'linux', 08:39:44 INFO - 'TMOUT': '86400', 08:39:44 INFO - 'USER': 'cltbld', 08:39:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:44 INFO - '_': '/tools/buildbot/bin/python'} 08:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:39:45 INFO - Cleaning up... 08:39:45 INFO - Return code: 0 08:39:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39: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')]} 08:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:45 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:39:45 INFO - Using env: {'DISPLAY': ':0', 08:39:45 INFO - 'HOME': '/home/cltbld', 08:39:45 INFO - 'LANG': 'en_US.UTF-8', 08:39:45 INFO - 'LANGUAGE': 'en_US:en', 08:39:45 INFO - 'LOGNAME': 'cltbld', 08:39:45 INFO - 'MAIL': '/var/mail/cltbld', 08:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:45 INFO - 'MOZ_NO_REMOTE': '1', 08:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:45 INFO - 'NO_EM_RESTART': '1', 08:39:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:45 INFO - 'PWD': '/builds/slave/test', 08:39:45 INFO - 'SHELL': '/bin/bash', 08:39:45 INFO - 'SHLVL': '1', 08:39:45 INFO - 'TERM': 'linux', 08:39:45 INFO - 'TMOUT': '86400', 08:39:45 INFO - 'USER': 'cltbld', 08:39:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:45 INFO - '_': '/tools/buildbot/bin/python'} 08:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:45 INFO - Downloading/unpacking psutil>=3.1.1 08:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:46 INFO - Installing collected packages: psutil 08:39:46 INFO - Running setup.py install for psutil 08:39:46 INFO - building 'psutil._psutil_linux' extension 08:39:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:39:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:39:46 INFO - building 'psutil._psutil_posix' extension 08:39:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:39:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:39:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:47 INFO - Successfully installed psutil 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:47 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:39:47 INFO - Using env: {'DISPLAY': ':0', 08:39:47 INFO - 'HOME': '/home/cltbld', 08:39:47 INFO - 'LANG': 'en_US.UTF-8', 08:39:47 INFO - 'LANGUAGE': 'en_US:en', 08:39:47 INFO - 'LOGNAME': 'cltbld', 08:39:47 INFO - 'MAIL': '/var/mail/cltbld', 08:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:47 INFO - 'MOZ_NO_REMOTE': '1', 08:39:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:47 INFO - 'NO_EM_RESTART': '1', 08:39:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:47 INFO - 'PWD': '/builds/slave/test', 08:39:47 INFO - 'SHELL': '/bin/bash', 08:39:47 INFO - 'SHLVL': '1', 08:39:47 INFO - 'TERM': 'linux', 08:39:47 INFO - 'TMOUT': '86400', 08:39:47 INFO - 'USER': 'cltbld', 08:39:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:47 INFO - '_': '/tools/buildbot/bin/python'} 08:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:48 INFO - Installing collected packages: mozsystemmonitor 08:39:48 INFO - Running setup.py install for mozsystemmonitor 08:39:48 INFO - Successfully installed mozsystemmonitor 08:39:48 INFO - Cleaning up... 08:39:48 INFO - Return code: 0 08:39:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:39:48 INFO - Using env: {'DISPLAY': ':0', 08:39:48 INFO - 'HOME': '/home/cltbld', 08:39:48 INFO - 'LANG': 'en_US.UTF-8', 08:39:48 INFO - 'LANGUAGE': 'en_US:en', 08:39:48 INFO - 'LOGNAME': 'cltbld', 08:39:48 INFO - 'MAIL': '/var/mail/cltbld', 08:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:48 INFO - 'MOZ_NO_REMOTE': '1', 08:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:48 INFO - 'NO_EM_RESTART': '1', 08:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:48 INFO - 'PWD': '/builds/slave/test', 08:39:48 INFO - 'SHELL': '/bin/bash', 08:39:48 INFO - 'SHLVL': '1', 08:39:48 INFO - 'TERM': 'linux', 08:39:48 INFO - 'TMOUT': '86400', 08:39:48 INFO - 'USER': 'cltbld', 08:39:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:48 INFO - '_': '/tools/buildbot/bin/python'} 08:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:50 INFO - warning: no files found matching '*.txt' 08:39:50 INFO - no previously-included directories found matching 'build' 08:39:50 INFO - no previously-included directories found matching 'dist' 08:39:50 INFO - no previously-included directories found matching '.git*' 08:39:50 INFO - Installing collected packages: jsonschema, functools32 08:39:50 INFO - Running setup.py install for functools32 08:39:50 INFO - warning: no files found matching '*.txt' 08:39:50 INFO - no previously-included directories found matching 'build' 08:39:50 INFO - no previously-included directories found matching 'dist' 08:39:50 INFO - no previously-included directories found matching '.git*' 08:39:50 INFO - Successfully installed jsonschema functools32 08:39:50 INFO - Cleaning up... 08:39:50 INFO - Return code: 0 08:39:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:50 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:39:50 INFO - Using env: {'DISPLAY': ':0', 08:39:50 INFO - 'HOME': '/home/cltbld', 08:39:50 INFO - 'LANG': 'en_US.UTF-8', 08:39:50 INFO - 'LANGUAGE': 'en_US:en', 08:39:50 INFO - 'LOGNAME': 'cltbld', 08:39:50 INFO - 'MAIL': '/var/mail/cltbld', 08:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:50 INFO - 'MOZ_NO_REMOTE': '1', 08:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:50 INFO - 'NO_EM_RESTART': '1', 08:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:50 INFO - 'PWD': '/builds/slave/test', 08:39:50 INFO - 'SHELL': '/bin/bash', 08:39:50 INFO - 'SHLVL': '1', 08:39:50 INFO - 'TERM': 'linux', 08:39:50 INFO - 'TMOUT': '86400', 08:39:50 INFO - 'USER': 'cltbld', 08:39:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:50 INFO - '_': '/tools/buildbot/bin/python'} 08:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:50 INFO - Cleaning up... 08:39:50 INFO - Return code: 0 08:39:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:50 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:39:50 INFO - Using env: {'DISPLAY': ':0', 08:39:50 INFO - 'HOME': '/home/cltbld', 08:39:50 INFO - 'LANG': 'en_US.UTF-8', 08:39:50 INFO - 'LANGUAGE': 'en_US:en', 08:39:50 INFO - 'LOGNAME': 'cltbld', 08:39:50 INFO - 'MAIL': '/var/mail/cltbld', 08:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:50 INFO - 'MOZ_NO_REMOTE': '1', 08:39:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:50 INFO - 'NO_EM_RESTART': '1', 08:39:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:50 INFO - 'PWD': '/builds/slave/test', 08:39:50 INFO - 'SHELL': '/bin/bash', 08:39:50 INFO - 'SHLVL': '1', 08:39:50 INFO - 'TERM': 'linux', 08:39:50 INFO - 'TMOUT': '86400', 08:39:50 INFO - 'USER': 'cltbld', 08:39:50 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:50 INFO - '_': '/tools/buildbot/bin/python'} 08:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:52 INFO - Downloading docopt-0.6.1.tar.gz 08:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:52 INFO - Running setup.py install for blobuploader 08:39:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:52 INFO - Running setup.py install for requests 08:39:52 INFO - Running setup.py install for docopt 08:39:53 INFO - Successfully installed blobuploader requests docopt 08:39:53 INFO - Cleaning up... 08:39:53 INFO - Return code: 0 08:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39: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')]} 08:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:53 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:53 INFO - Using env: {'DISPLAY': ':0', 08:39:53 INFO - 'HOME': '/home/cltbld', 08:39:53 INFO - 'LANG': 'en_US.UTF-8', 08:39:53 INFO - 'LANGUAGE': 'en_US:en', 08:39:53 INFO - 'LOGNAME': 'cltbld', 08:39:53 INFO - 'MAIL': '/var/mail/cltbld', 08:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:53 INFO - 'MOZ_NO_REMOTE': '1', 08:39:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:53 INFO - 'NO_EM_RESTART': '1', 08:39:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:53 INFO - 'PWD': '/builds/slave/test', 08:39:53 INFO - 'SHELL': '/bin/bash', 08:39:53 INFO - 'SHLVL': '1', 08:39:53 INFO - 'TERM': 'linux', 08:39:53 INFO - 'TMOUT': '86400', 08:39:53 INFO - 'USER': 'cltbld', 08:39:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:53 INFO - '_': '/tools/buildbot/bin/python'} 08:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:53 INFO - Running setup.py (path:/tmp/pip-7UDx1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:53 INFO - Running setup.py (path:/tmp/pip-YcSRNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:53 INFO - Running setup.py (path:/tmp/pip-VOx4TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:53 INFO - Running setup.py (path:/tmp/pip-jQI5dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:53 INFO - Running setup.py (path:/tmp/pip-paKfYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:53 INFO - Running setup.py (path:/tmp/pip-pZddpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:53 INFO - Running setup.py (path:/tmp/pip-RR7Iqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:53 INFO - Running setup.py (path:/tmp/pip-sKNcaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:53 INFO - Running setup.py (path:/tmp/pip-w_qq4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:53 INFO - Running setup.py (path:/tmp/pip-Badj0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:54 INFO - Running setup.py (path:/tmp/pip-EQ34oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:54 INFO - Running setup.py (path:/tmp/pip-zZxdnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:54 INFO - Running setup.py (path:/tmp/pip-1MFnTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:54 INFO - Running setup.py (path:/tmp/pip-O7WW9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:54 INFO - Running setup.py (path:/tmp/pip-tHbl8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:54 INFO - Running setup.py (path:/tmp/pip-ux8DRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:54 INFO - Running setup.py (path:/tmp/pip-z7VYEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:54 INFO - Running setup.py install for manifestparser 08:39:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:54 INFO - Running setup.py install for mozcrash 08:39:54 INFO - Running setup.py install for mozdebug 08:39:54 INFO - Running setup.py install for mozdevice 08:39:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:54 INFO - Running setup.py install for mozfile 08:39:55 INFO - Running setup.py install for mozhttpd 08:39:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozinfo 08:39:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozInstall 08:39:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozleak 08:39:55 INFO - Running setup.py install for mozlog 08:39:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for moznetwork 08:39:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozprocess 08:39:55 INFO - Running setup.py install for mozprofile 08:39:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozrunner 08:39:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Running setup.py install for mozscreenshot 08:39:56 INFO - Running setup.py install for moztest 08:39:56 INFO - Running setup.py install for mozversion 08:39:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:56 INFO - Cleaning up... 08:39:56 INFO - Return code: 0 08:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39: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')]} 08:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:56 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:56 INFO - Using env: {'DISPLAY': ':0', 08:39:56 INFO - 'HOME': '/home/cltbld', 08:39:56 INFO - 'LANG': 'en_US.UTF-8', 08:39:56 INFO - 'LANGUAGE': 'en_US:en', 08:39:56 INFO - 'LOGNAME': 'cltbld', 08:39:56 INFO - 'MAIL': '/var/mail/cltbld', 08:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:56 INFO - 'MOZ_NO_REMOTE': '1', 08:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:56 INFO - 'NO_EM_RESTART': '1', 08:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:56 INFO - 'PWD': '/builds/slave/test', 08:39:56 INFO - 'SHELL': '/bin/bash', 08:39:56 INFO - 'SHLVL': '1', 08:39:56 INFO - 'TERM': 'linux', 08:39:56 INFO - 'TMOUT': '86400', 08:39:56 INFO - 'USER': 'cltbld', 08:39:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:56 INFO - '_': '/tools/buildbot/bin/python'} 08:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:56 INFO - Running setup.py (path:/tmp/pip-icCXnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:56 INFO - Running setup.py (path:/tmp/pip-uE4IXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:56 INFO - Running setup.py (path:/tmp/pip-9RvyVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:56 INFO - Running setup.py (path:/tmp/pip-8jmm9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:56 INFO - Running setup.py (path:/tmp/pip-w2ah5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:56 INFO - Running setup.py (path:/tmp/pip-QlUNPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:56 INFO - Running setup.py (path:/tmp/pip-VCXtoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:57 INFO - Running setup.py (path:/tmp/pip-zg16tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:57 INFO - Running setup.py (path:/tmp/pip-wi7Tdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:57 INFO - Running setup.py (path:/tmp/pip-ytWm_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:57 INFO - Running setup.py (path:/tmp/pip-cq_ItG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:57 INFO - Running setup.py (path:/tmp/pip-xfuNY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:57 INFO - Running setup.py (path:/tmp/pip-JRj8UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:57 INFO - Running setup.py (path:/tmp/pip-4nKjEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:57 INFO - Running setup.py (path:/tmp/pip-HGYodP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:57 INFO - Running setup.py (path:/tmp/pip-dSPvI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:57 INFO - Running setup.py (path:/tmp/pip-EeCDIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:39:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:58 INFO - Downloading blessings-1.6.tar.gz 08:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:58 INFO - Installing collected packages: blessings 08:39:58 INFO - Running setup.py install for blessings 08:39:59 INFO - Successfully installed blessings 08:39:59 INFO - Cleaning up... 08:39:59 INFO - Return code: 0 08:39:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:59 INFO - Reading from file tmpfile_stdout 08:39:59 INFO - Current package versions: 08:39:59 INFO - argparse == 1.2.1 08:39:59 INFO - blessings == 1.6 08:39:59 INFO - blobuploader == 1.2.4 08:39:59 INFO - docopt == 0.6.1 08:39:59 INFO - functools32 == 3.2.3-2 08:39:59 INFO - jsonschema == 2.5.1 08:39:59 INFO - manifestparser == 1.1 08:39:59 INFO - mozInstall == 1.13 08:39:59 INFO - mozcrash == 1.0 08:39:59 INFO - mozdebug == 0.1 08:39:59 INFO - mozdevice == 0.51 08:39:59 INFO - mozfile == 1.2 08:39:59 INFO - mozhttpd == 0.7 08:39:59 INFO - mozinfo == 0.10 08:39:59 INFO - mozleak == 0.1 08:39:59 INFO - mozlog == 3.5 08:39:59 INFO - moznetwork == 0.27 08:39:59 INFO - mozprocess == 0.25 08:39:59 INFO - mozprofile == 0.28 08:39:59 INFO - mozrunner == 6.13 08:39:59 INFO - mozscreenshot == 0.1 08:39:59 INFO - mozsystemmonitor == 0.3 08:39:59 INFO - moztest == 0.8 08:39:59 INFO - mozversion == 1.4 08:39:59 INFO - psutil == 3.1.1 08:39:59 INFO - requests == 1.2.3 08:39:59 INFO - wsgiref == 0.1.2 08:39:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39: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')]} 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:59 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:59 INFO - Using env: {'DISPLAY': ':0', 08:39:59 INFO - 'HOME': '/home/cltbld', 08:39:59 INFO - 'LANG': 'en_US.UTF-8', 08:39:59 INFO - 'LANGUAGE': 'en_US:en', 08:39:59 INFO - 'LOGNAME': 'cltbld', 08:39:59 INFO - 'MAIL': '/var/mail/cltbld', 08:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:59 INFO - 'MOZ_NO_REMOTE': '1', 08:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:59 INFO - 'NO_EM_RESTART': '1', 08:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:59 INFO - 'PWD': '/builds/slave/test', 08:39:59 INFO - 'SHELL': '/bin/bash', 08:39:59 INFO - 'SHLVL': '1', 08:39:59 INFO - 'TERM': 'linux', 08:39:59 INFO - 'TMOUT': '86400', 08:39:59 INFO - 'USER': 'cltbld', 08:39:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:59 INFO - '_': '/tools/buildbot/bin/python'} 08:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:39:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:40:00 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:40:00 INFO - Installing collected packages: marionette-driver, simplejson 08:40:00 INFO - Running setup.py install for marionette-driver 08:40:01 INFO - Running setup.py install for simplejson 08:40:01 INFO - building 'simplejson._speedups' extension 08:40:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:40:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:40:02 INFO - Successfully installed marionette-driver simplejson 08:40:02 INFO - Cleaning up... 08:40:02 INFO - Return code: 0 08:40:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40: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')]} 08:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:02 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 0x174d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abeb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, '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': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:40:02 INFO - Using env: {'DISPLAY': ':0', 08:40:02 INFO - 'HOME': '/home/cltbld', 08:40:02 INFO - 'LANG': 'en_US.UTF-8', 08:40:02 INFO - 'LANGUAGE': 'en_US:en', 08:40:02 INFO - 'LOGNAME': 'cltbld', 08:40:02 INFO - 'MAIL': '/var/mail/cltbld', 08:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:02 INFO - 'MOZ_NO_REMOTE': '1', 08:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:02 INFO - 'NO_EM_RESTART': '1', 08:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:02 INFO - 'PWD': '/builds/slave/test', 08:40:02 INFO - 'SHELL': '/bin/bash', 08:40:02 INFO - 'SHLVL': '1', 08:40:02 INFO - 'TERM': 'linux', 08:40:02 INFO - 'TMOUT': '86400', 08:40:02 INFO - 'USER': 'cltbld', 08:40:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:02 INFO - '_': '/tools/buildbot/bin/python'} 08:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:02 INFO - Cleaning up... 08:40:02 INFO - Return code: 0 08:40:02 INFO - Running post-action listener: _resource_record_post_action 08:40:02 INFO - Running post-action listener: _start_resource_monitoring 08:40:02 INFO - Starting resource monitoring. 08:40:02 INFO - [mozharness: 2017-07-16 15:40:02.362866Z] Finished create-virtualenv step (success) 08:40:02 INFO - [mozharness: 2017-07-16 15:40:02.363379Z] Running install step. 08:40:02 INFO - Running pre-action listener: _resource_record_pre_action 08:40:02 INFO - Running main action method: install 08:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:02 INFO - Reading from file tmpfile_stdout 08:40:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:02 INFO - Reading from file tmpfile_stdout 08:40:02 INFO - Output received: 08:40:02 INFO - Usage: mozinstall [options] installer 08:40:02 INFO - Options: 08:40:02 INFO - -h, --help show this help message and exit 08:40:02 INFO - -d DEST, --destination=DEST 08:40:02 INFO - Directory to install application into. [default: 08:40:02 INFO - "/builds/slave/test"] 08:40:02 INFO - --app=APP Application being installed. [default: firefox] 08:40:02 INFO - mkdir: /builds/slave/test/build/application 08:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:40:20 INFO - Reading from file tmpfile_stdout 08:40:20 INFO - Output received: 08:40:20 INFO - /builds/slave/test/build/application/firefox/firefox 08:40:20 INFO - Running post-action listener: _resource_record_post_action 08:40:20 INFO - [mozharness: 2017-07-16 15:40:20.434724Z] Finished install step (success) 08:40:20 INFO - [mozharness: 2017-07-16 15:40:20.434871Z] Running setup-mitmproxy step. 08:40:20 INFO - Running pre-action listener: _resource_record_pre_action 08:40:20 INFO - Running main action method: setup_mitmproxy 08:40:20 INFO - Skipping: mitmproxy is not required 08:40:20 INFO - Running post-action listener: _resource_record_post_action 08:40:20 INFO - [mozharness: 2017-07-16 15:40:20.435406Z] Finished setup-mitmproxy step (success) 08:40:20 INFO - [mozharness: 2017-07-16 15:40:20.435518Z] Running run-tests step. 08:40:20 INFO - Running pre-action listener: _resource_record_pre_action 08:40:20 INFO - Running pre-action listener: _set_gcov_prefix 08:40:20 INFO - Running main action method: run_tests 08:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:40:20 INFO - Python 2.7.3 08:40:20 INFO - Return code: 0 08:40:20 INFO - grabbing minidump binary from tooltool 08:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:20 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 0x1abbd00>, '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 0x1abcc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1abd090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:40:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:40:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:40:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:40:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:20 INFO - Return code: 0 08:40:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:40:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:40:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:40:20 INFO - ENV: RUST_BACKTRACE is now 1 08:40:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:40:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:40:20 INFO - Using env: {'DISPLAY': ':0', 08:40:20 INFO - 'HOME': '/home/cltbld', 08:40:20 INFO - 'LANG': 'en_US.UTF-8', 08:40:20 INFO - 'LANGUAGE': 'en_US:en', 08:40:20 INFO - 'LOGNAME': 'cltbld', 08:40:20 INFO - 'MAIL': '/var/mail/cltbld', 08:40:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:40:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:20 INFO - 'MOZ_NO_REMOTE': '1', 08:40:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:20 INFO - 'NO_EM_RESTART': '1', 08:40:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:20 INFO - 'PWD': '/builds/slave/test', 08:40:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:40:20 INFO - 'RUST_BACKTRACE': '1', 08:40:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:40:20 INFO - 'SHELL': '/bin/bash', 08:40:20 INFO - 'SHLVL': '1', 08:40:20 INFO - 'TERM': 'linux', 08:40:20 INFO - 'TMOUT': '86400', 08:40:20 INFO - 'USER': 'cltbld', 08:40:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269', 08:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:20 INFO - '_': '/tools/buildbot/bin/python'} 08:40:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:40:20 INFO - mozversion application_buildid: 20170716143154 08:40:20 INFO - mozversion application_changeset: c1185e615e55949151f20c66d55b0e7e62034adb 08:40:20 INFO - mozversion application_display_name: Nightly 08:40:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:20 INFO - mozversion application_name: Firefox 08:40:20 INFO - mozversion application_remotingname: firefox 08:40:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:40:20 INFO - mozversion application_vendor: Mozilla 08:40:20 INFO - mozversion application_version: 56.0a1 08:40:20 INFO - mozversion platform_buildid: 20170716143154 08:40:20 INFO - mozversion platform_changeset: c1185e615e55949151f20c66d55b0e7e62034adb 08:40:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:40:20 INFO - mozversion platform_version: 56.0a1 08:40:20 INFO - using testdate: 1500219620 08:40:20 INFO - actual date: 1500219620 08:40:20 INFO - starting webserver on 'localhost:38513' 08:40:20 INFO - SUITE-START | Running 2 tests 08:40:20 INFO - TEST-START | dromaeo_css 08:40:20 INFO - Initialising browser for dromaeo_css test... 08:40:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38513/getInfo.html -profile /tmp/tmplO3xWk/profile 08:40:20 INFO - TEST-INFO | started process 26222 (/builds/slave/test/build/application/firefox/firefox http://localhost:38513/getInfo.html) 08:40:26 INFO - TEST-INFO | 26222: exit 0 08:40:26 INFO - Browser initialized. 08:40:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:40:26 INFO - TEST-INFO | started process 26428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplO3xWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:38 INFO - PID 26428 | RSS: Main: 160342016 08:40:38 INFO - PID 26428 | 08:43:35 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38513/tests/dromaeo/cssquery-ext.html) 08:43:37 INFO - PID 26428 | RSS: Main: 168472576 08:43:37 INFO - PID 26428 | 08:46:38 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-ext.html (next: http://localhost:38513/tests/dromaeo/cssquery-jquery.html) 08:46:39 INFO - PID 26428 | RSS: Main: 166699008 08:46:39 INFO - PID 26428 | 08:49:41 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38513/tests/dromaeo/cssquery-mootools.html) 08:49:41 INFO - PID 26428 | RSS: Main: 169144320 08:49:41 INFO - PID 26428 | 08:52:43 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38513/tests/dromaeo/cssquery-prototype.html) 08:52:43 INFO - PID 26428 | RSS: Main: 168165376 08:52:43 INFO - PID 26428 | 08:55:46 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38513/tests/dromaeo/cssquery-yui.html) 08:55:47 INFO - PID 26428 | RSS: Main: 167555072 08:55:47 INFO - PID 26428 | 08:58:48 INFO - PID 26428 | Cycle 1(1): loaded http://localhost:38513/tests/dromaeo/cssquery-yui.html (next: http://localhost:38513/tests/dromaeo/cssquery-dojo.html) 08:58:49 INFO - PID 26428 | RSS: Main: 170643456 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | __start_tp_report 08:58:49 INFO - PID 26428 | _x_x_mozilla_page_load 08:58:49 INFO - PID 26428 | _x_x_mozilla_page_load_details 08:58:49 INFO - PID 26428 | |i|pagename|runs| 08:58:49 INFO - PID 26428 | |0;dojo.html;3378.493226016099;3384.306217225469;3407.3696366172244;3420.640832712564;3423.8801641942523;6095.634261944281;6242.781502647403;6258.561900666955;6281.183446151994;6283.560150789435;6067.908981365283;6140.8464788380315;6141.6622085785375;6155.6306621602735;6166.660833654148;5383.273258110164;5407.270018547505;5421.756020979065;5430;5449.782008719647;5404.621676482648;5440.211169380437;5450.5639548836;5462.262594549725;5500.257465242201;5457.399686034533;5459.535939445152;5476.58925580581;5495.53287970523;5495.890082198373;5412.052890744143;5424.945750542503;5446.482584154499;5446.91829622556;5462.781488740446;5373.731313434352;5421.620486565942;5450.236966824647;5497.147942068986;5578.163275508666;5961.314448838396;6045.063015232646;6060.727267272983;6078;6101.572889897709;6418.93581064188;6500.089987401768;6577.112089867855;6583.473322134218;6600.60396376219;6578.868422631521;6611.504137189682;6614.338566143395;6635.3032931541975;6636.469082473391;6132.264128304588;6221.533384996098;6240.781572644981;6302.4958003359625;6312.053192021188;6893.724251030003;6907.756603811362;6917.066196063568;7015.8596828063155;7016.5088443808445;6373.044043393528;6597.043428702811;6665;6668.366505182;6676.232233293136;6565.474762019027;6569.80290591283;6572;6586.934130658632;6587.110740050032;6358.173437453194;6496.187976502937;6502.804915852532;6528.151340325728;6536.575122617015;5704.674337422438;6603.537752357289;6627.403533681895;6656.034874943106;6672;4965.255211718271;4983.401991761012;5020.171671674133;5027.296178535008;5033.0437216929395;4379.759113248738;4429.623482004002;4450.554944505524;4494.5730155635165;4500.527444618333;6099.603525770811;6139.416755408229;6149.016157414792;6159.1069294951985;6170.56806023583;6509.479241660656;6574.243961944342;6574.506911981621;6580.934190658128;6592.077109204715;6119.265688117454;6121.632702037892;6132.78535251264;6158.907616385758;6172.598781079216;4842;5569.721513924287;5661.801836935688;5680.943190568124;5770.740316685759;6849.486288528281;6872.278410766898;6873.278305777922;6879.89680154798;6880.277570854988;6599.340065993459;6614.437772789367;6619.404253617197;6624.27133015368;6732.663366831737;6973.546719463218;6980.650967451708;7045.506814523139;7049.894251586333;7070.469714771516;6608.636524991171;6626.635535045426;6654.234763002317;6680.899786503303;6695.531312808057;6542.182227221598;6638.037484564615;6638.966805165944;6641.369069938348;6647.800565983028;5324.307839980777;6361.077643741724;6419.390157934989;6507.089007539043;6564.606123632598;6482.546221764431;6484.059811327237;6550.017497375432;6581.3747693969;6586.967065164644;6486.772962946275;6513.576617519846;6543.934560654333;6581.407673309425;6594.076829243813;6330;6435.967820160869;6496.870062598627;6507.023946408077;6628.105205797156;6276.9372306276355;6277.435030847246;6281.277653069956;6289.622622642656;6293.937060629335 08:58:49 INFO - PID 26428 | |1;ext.html;871.146944594661;909.5861383070708;942.5475771629617;965.6861520005991;966.1304825656912;42225.366619500695;43238.35142472858;43440.348394774104;43524.12951740963;43830;39626.20747585054;39968.200635987334;40071.799641001824;40121.799391003005;40156.39765403514;6727.024581435689;6781.559198652097;6831.1119554457855;6843.965780171092;6858;6759.155105611799;6777.69500372482;6793.116894803668;6814.6933387997415;6833.180018397799;6782.830429239284;6826.69279882404;6834.897476537856;6866.485013623973;6868.931310686904;6737.157855268091;6787.4909381796315;6813.250542440328;6823.795286141423;6843.62360070196;6263.091851681481;6309.3690630937;6311;6332.556721029529;6339.36606339367;35099.29801403983;35309.470357944396;35343.29313413717;35430.29139417223;35474.645253547395;3374.122728090714;3377.9831100844585;3395.813230272334;3459.550258466383;3492.668196521352;32125.51811722826;32710;32747.6725232747;32781.508277375855;32840.50739238913;4955.1328517509655;4985.501449855022;5010.874728131789;5030.2957585938;5124.333836601218;205218;208589;209022;209043.95478022666;209219;47651.285230721565;50300.74849625801;50728;50776.492235077916;51044.23433648498;52643.73678131661;52701.472985269655;52896;52914;52974.470255297725;16667.33330666784;16694.749578756328;16819.495415137564;16840.915795420944;16878.987260764392;13875.791863122062;13966.790498142536;14015.85984140166;14016.85983140176;14036.859631403759;14398.42406303757;14500.782488262685;14527.418903243963;14538.055026423248;14622.610851969046;5686.943130568724;5788.9710551447815;5826.883462330815;5829.533637309005;5992.490638295706;1055.1137044882182;1102.459794700607;1102.5755084292605;1107.9224454288124;1110.2339385823757;25001.249962501155;25088.372790680012;25130.748692513207;25201.24396268115;25216.24351269428;1199.322382853685;1214.09549885336;1220.2617416462913;1228.2078059651474;1237.2514628649717;13047.478100875858;13184.670383240496;13294.202347858965;13312.467501300032;13397.933010334886;279607;279887;280594;280929;281450;55862;56041.7197914016;56268.718656406454;56564;56642.716786415804;1472.1902953375816;1520.2854658310798;1535.7466018107111;1537.961550961235;1567.388718399825;24446.877765611058;29761;29946.70053299439;29985;30604.693953060185;54206.45793542014;54841;54932.72533637306;55393.72303138459;55401.44598554124;239372;239726;240491;241227;242695;34546.65453345434;34797.13007174841;34960.650393496755;37055.444168338036;37303.253934920605;41448.37827432651;45656.54343456523;45837.770811147064;46034.76982615065;46716.299255510516;32053;32817.835910821246;33053.834730826195;33320.666793332726;34902.65097348994;34408.311833763684;35333.823330883184;35356.64643353636;35555.93332200038;35922.46116308205;41394.58605413907;41437.58562414337;41759.373609395276;41950.16099677928;42078.36882446705;34238.657613423544;34440.655593444746;34513.30973380568;34526.48210276798;34749.30501389907;24953.251402457954;25692.87153564295;25768.484630306913;25769.484610308064;26263.868680656473 08:58:49 INFO - PID 26428 | |2;jquery.html;556.1685280505643;561.5703986450363;567.3107174782639;574.5145352177411;594.6729298885613;22298.442538936535;22895.771042289573;22903.541929161405;23014.769852301513;23171.18900838471;25664;26835.060772872952;28363;28442.715572844267;28502.857485712542;6265.7493700251935;6445.129907462479;6445.51658625605;6447.54867159299;6459.967700161493;6325.399087086719;6334.271558770754;6339.397757213057;6340.017297318923;6344.4607208387115;4203.096334288128;5146.974265128669;6318.336574659664;6848.931510684879;6863.725450981955;6822.215445223788;6826.4538836892925;6848.417884479825;6851.38337549618;6875.037494750739;6721.663916804189;6725.361090696376;6727.697253623599;6730.125083739083;6741.3258674132685;31533.84233078843;33341.333173336396;33692.15769605755;33802.49296260558;34178.145546361295;2262.049939025613;2308.445972966476;2325.755795641467;2329.580675478413;2333.5916214662366;20412.183512659474;20857.478563035893;21089.3673189803;21197.046132924057;21206.787932120635;2373.8457000294925;2465.469923966356;2532.6327682485935;2563.115725074846;2577.7164511903675;144616.27691861472;148191;148278.25860870734;150294;151307;21607.67588486174;23164.420889477897;23785.405364866016;24420.63369049466;24567.14015009466;47898.5210147901;47949;47979.76010119997;48212;48506.27240591394;11879;11938.462769175409;12126.878731212752;12220.1445898788;12527;10091.142252908585;10118;10138.949305253427;10228.744281393025;10231.232657550714;11954.940225298818;12081.637550873313;12126.211796233216;12189.756204875854;12459.93770031144;3340.716039136652;3605.603383627851;3964.4736776341315;4075.8847646203826;4121.855735049259;1008.6268080810147;1011.9190464762802;1016.1768967136643;1058.6771034834296;1064.3401091323428;21179;21235.150593976377;21464.939705225486;21984.670229946565;22104.115835366407;1090.4711215060688;1097.665212110314;1098.6594155811724;1110.5557776889148;1116.8827273136367;11703.23928944616;11796.705082372837;12130;12209.084318676134;12315.50737970489;545172;545304;554529;557774;559248;124318.37840810738;128932;129660;130642;133342;1219.4817701446484;1221.7190046289224;1230.4155526125019;1239.900807935363;1240.2806372304221;18206;19127.904360478107;19267.614647706687;19497.902510487358;19523.70714439256;59821;60114.09828852483;61199.69400153149;62866.371336287884;63245;79749;79800;80006;81100;81242.59378703068;21462.570748585254;21758.56482870302;22578;22584.322470325915;22592;19692.40922772319;20285.49286267855;20545.48636284105;23970.88014559916;24791.380215494755;18388.908055459637;19052.523686907938;20004;20197.79802202018;20213;17182.914085429493;17385.21766520535;17430.128493575525;17495.475135745946;17941.730874037163;19792.90103549473;20042.39872803818;20090.296839610543;20211.59576808485;20212;20000.099995500528;20852.895735521226;20955.37133885986;21292.467688307916;21466.14135434565;19730.210791568177;19816.70274945848;19834.305799296955;19856.503587409854;20092 08:58:49 INFO - PID 26428 | |3;mootools.html;1425.2517428350116;1483.6958423523165;1500.9399624015036;1503.8872084593659;1505.872000879925;14952.626184345398;15672.216389180552;15716.685666286681;15742.370305187778;15799.447019354297;14734.410623575071;15275.770863437057;15927.522174334788;15944;15997.84002159978;2689.744474274946;2758.5724212747054;2766.7509924106826;2776.847273399962;2778.4304217635436;2685.6374389457465;2752.587111933216;2758.7379198976164;2767.958480622792;2772.0575004498464;2625.514279858223;2685.8388496690163;2714.7556719895206;2716.7283271672873;2803.032953630994;2679.624852520649;2691.4078902641386;2699.1092939329974;2704.4591081783724;2707.5126477233994;2608.113241497881;2645.933851653705;2648.9867550662316;2657.827241229314;2661.2548486423834;14915.850841491554;15250.542483725507;15251.23743812805;15274.694506109927;15337.846621533754;8226.506409615442;8493.235608795238;8559.186877246651;8561.486310821309;8576.39965202436;5172.27588137661;5347.54545863602;5423.159410291411;5463.480969307949;5477.561795056426;1847.0288878910317;1854.4158590044092;1887.2545344588948;1920.817522335376;1921.1162865082078;26866.462670746474;26960.73039269602;26998.190054298404;27026.459470810474;27035;6813.761518346933;6970.825729356807;7100.68046937889;7144.607046612487;7225.277472252733;17920.9103954482;17961.461156165336;18009;18036.458906232834;18043.368482103062;7900.841983160304;8314;8350.874736878952;8367.95816020916;8367.99584049918;7534.736284230025;7652.961735191399;7810.687572497037;7851.293383595504;7893.684252629945;5190.506901844319;5297.761600727977;5365.061114304981;5405.648632838853;5472.425395333512;1565.9921700391426;1575.8109026916613;1575.8581727644337;1621.1894052973514;1631.6655085707403;904.5929331800716;920.5673333533229;935.5930170375908;944.730751735752;957.1194501059042;8695.739127826175;8810.647574097093;8934.41926274803;9297.30270229722;9740.36687615317;976.4629453800381;1019.4545917934018;1031.041131747482;1042.0361165921493;1051.1380667852288;5215.973920130375;5244.819915518978;5254.7635356409055;5266.999270138738;5360.705161216092;19816;20418.59162816765;20468.488287792923;20687.793122068586;20899.895500522704;21034.47413814667;21099.78900210978;21549.569008620052;21580.784192158193;22065.227717029826;11711.297322160697;11868.347240901661;12036.277823330629;12198.329091899854;12406.441710123067;8027.237412445808;8247.628856701584;8378.958105209435;8408.495490270603;8635.481871087755;18875.716864247323;18930.337438189596;19159.425217243504;19314.227430902607;19652.901735491803;18719.625607487502;18955.90522047381;19690.21239150418;19972.10125544383;20137.59724805525;12685;12904.741905162033;13374.732505350034;14067.155970641794;14348.641283967985;14185.077969931921;14481.275936203358;14547.418103276173;14550.417983280973;14606.269686515845;11255.268407553483;11333.320000799979;11429.428528573704;11593.594224202112;11636.36000020007;9835.360701554377;10693.358398496115;11227.887721122685;11333.376664283544;11606.419679015846;10281.74295642615;10333.948330258301;10339.121174700234;10365;10419.322744021614;7301.598412087386;7470.925290747023;7616.162222155448;7660.73187438437;7726.227377262228;7680.692772289046;7730.845383092419;7815.921840781747;7826.139124696393;7869.331106855752 08:58:49 INFO - PID 26428 | |4;prototype.html;468.29755366949576;484.78669385470414;500.85975926740514;506.4201489294758;515.3558052434455;5870.148828419882;5875.88248235035;5923.6149650272755;5936.58443908926;6061.1211374350805;5711.2575365202565;5862.560307976897;5888.381719919411;5936.7031648417515;5956.970215148918;4651.1162879053045;4651.279051746985;4658.998315362196;4664.8134074637055;4681.83613573525;4657.347971284023;4672.883177920562;4694.319323698061;4703.15343238217;4706;4472.597466228039;4603.3785438965815;4627.236505976527;4633.6061434778085;4655.301704744282;4613.1696294666945;4640.628749700016;4672.229082201433;4707.95292047082;4711.24620060792;4229.809658565341;4253.723507971972;4255.6169944705125;4256.701705979675;4256.829726810924;5802.82591522255;5884.529237660977;5910.586258961875;5916.852078698024;5939.524838012949;5492.835214943558;5502;5521.641093328921;5527.640703354269;5546.195801608785;6288.654124023177;6311.810645680637;6400;6408.839779005515;6425.357464253584;4771.8091276348905;4772.42730872294;4802.207635740098;4802.543758342952;4806.687565308243;6569.57297775643;6596.472282217459;6631.767888123893;6682.766103186365;6700.329967003309;4909.3126962225315;4925.798231149782;4953.826616068421;4956.4547899731;4957.677750946249;4940.2342636891335;4942.159832828428;4961.3798275215595;4980.626453016038;4999.225120106316;5491.9290738306445;5537.224788529609;5537.473939975695;5548.140038294071;5567.66594004361;6358.713857876407;6367.395097465826;6383.808485745435;6399.456046236029;6413.518986076063;1715.9571010724583;1739.773829402195;1746.3451205797826;1748.1259370314842;1749.1691446562781;1112.1603189591967;1123.775244951013;1143.5140065472142;1149.7528031473107;1220.4934951994824;5866.384029676822;5911.822645320647;5966.880662386815;5986.880262394728;5988.461038506555;6486.416222539994;6526.216853977553;6539.149910511698;6543.9202531582705;6576.1122248496795;6010.4891084258325;6013.188219590387;6053.878922421527;6055.757769689163;6059.091136329498;3382.3235352929514;3388.8983330500123;3389.3053473263367;3390.1524618845287;3393.355262500117;6633.568818026813;6662.669264977803;6686.957434367351;6702.865942681216;6833.3166683331265;6590.143281373391;6600.53796234259;6613.14029176204;6677.933220667731;6692.799216023527;6777.559458635173;6799.218089919624;6860.588364698134;6879.58722476653;6912.271932016995;6490.740370385131;6501.6424096673245;6502.73989040452;6524.4780417565535;6558.573692709959;6338.651374174465;6352.745890164341;6413.839654008687;6418.582792118497;6451.774187903401;6611.504137189634;6696.631685257357;6725.092112564741;6768.796936091925;6818.522703410714;4871.780769865293;4882.731449770296;4901.975490122527;4906.926396104132;4912.263160525807;6436.9034464484;6439.581427207217;6478.481721462366;6519.902201467076;6546.476281897532;6244.750209991549;6255.749770009149;6332.588381755171;6362.840928976812;6393;6286.685665716787;6288.151099601495;6303.573124347067;6329.778457753957;6346.238451385863;6206.937930620636;6242.656653883898;6282.465990390868;6301.779437719658;6316.305206427382;5748.252727145445;6259.906101408392;6293.716782744696;6335.180844524327;6366;6160.751325766153;6167.259928808572;6172.4136207060255;6211.316645269528;6262.624242545462 08:58:49 INFO - PID 26428 | |5;yui.html;943.2029934705176;945.7516078776015;957.8228027814855;961.9855702164465;970.9271255262935;17870.374536891195;17994.550136246602;18010.09949502526;18984.240630374785;19349.129289181987;17321.7401738974;17593.120343982813;17734.113294335264;17764.733528997043;19361.709574356395;1040.5525623981666;1045.5347370420166;1051.395447617623;1054.4042615922017;1066.4401189375562;1093.518851705251;1094.026316578246;1094.316052467208;1095.956161753529;1097.9341239525613;1143.3082984794205;1145.9770804583902;1156.9016633586155;1157.0801213035616;1160.3038177093717;1063.383237722123;1100.7358234023777;1101.7796440711809;1142.5658249865082;1148.0299147220585;806.1978331560135;806.8668669669497;807.4428644235459;810.7324582887633;810.9918900810975;19473;19743.21027158912;19894.70157947632;19930.601387972158;19931.50171245716;18729.15718792644;19727.112279947294;20069.698954515694;20116.798832011784;20137.09383077765;16030.358785648677;16071.919640401724;16097.195140243059;16112.75830862538;16115;3451.775634583744;3562.8040457774814;3570.7143428525656;3723.1436769543157;3728.981355093207;128351.35824320912;128512;134808.3259583696;135387;137672.31163844216;15513.379464821506;16229.918850405673;16231.918840405722;16710;16736.665266694843;30755;30783;31049.223769405944;31184.53223201654;31379.05862824073;9051.411658242194;9150.222231110298;9164.404313719588;9185.494797786187;9212.493312867857;4355.586219309161;4460.330950357407;4507.256302710016;4568.109218702388;4570.771461426915;5127.948720512747;5349.919751203735;5352.170413585901;5369.19462080691;5384.0847056000575;1009.8939611340703;1038.0501840815568;1044.6604853422668;1059.0838924330399;1070.117153348475;721.4733244731375;723.8237863471858;730.9597972111478;746.4550877859193;762.142589586715;12382.318972456422;12681.365931703378;12710.745785084246;12806.551770687982;12985.805212921814;720.2401466452837;731.7036600176937;737;744.6016381236012;751.2600088912417;5882.264716910387;5909.615874968199;5982.790602328984;6031.638101713911;6068.878622427526;117119;120303.39848300703;121928.39035804765;125774;127874;105023.4748826251;111088.44455777669;112441.43779281215;114293.42853285681;116074.41962790133;89456.5527172373;89959;92287;93372.53313733524;93504.06495934953;12798.808017879925;13021;13333;13421;13530.391132399263;41327;44317.556824432635;44934.3259851109;46043.30935036044;46662.76668616635;57155.71422142863;74214.62892685719;79745.00637484109;80218;80335;19913.402597922086;20035.799642003392;20724.58550828945;20872.47818804542;20918.790812091684;21727.782722172575;22360.552788944457;22810.88594557083;23753.52492950166;23827.166049188196;19899.204031839145;20278.188872444938;20427.897860510602;20455.69316460284;20939.8953005234;19182.904085479484;20522.07650655754;20567.485812854797;20735.8963205183;21019.474513137295;20572.897135514228;21130.260440884496;21310;21419.250326238507;21651;14143.787843182567;14193.290335482978;14215.50245741394;15008.174550399834;15095.622609434413;14920.955533112578;15226.619334516725;15422.383104675688;15625.921870390575;15677.372905083668 08:58:49 INFO - PID 26428 | __end_tp_report 08:58:49 INFO - PID 26428 | __start_cc_report 08:58:49 INFO - PID 26428 | _x_x_mozilla_cycle_collect,332 08:58:49 INFO - PID 26428 | __end_cc_report 08:58:49 INFO - PID 26428 | __startTimestamp1500220729083__endTimestamp 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | ------- Summary: start ------- 08:58:49 INFO - PID 26428 | Number of tests: 6 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | [#0] dojo.html Cycles:165 Average:6097.63 Median:6330.00 stddev:766.72 (12.1%) stddev-sans-first:738.80 08:58:49 INFO - PID 26428 | Values: 3378.5 3384.3 3407.4 3420.6 3423.9 6095.6 6242.8 6258.6 6281.2 6283.6 6067.9 6140.8 6141.7 6155.6 6166.7 5383.3 5407.3 5421.8 5430.0 5449.8 5404.6 5440.2 5450.6 5462.3 5500.3 5457.4 5459.5 5476.6 5495.5 5495.9 5412.1 5424.9 5446.5 5446.9 5462.8 5373.7 5421.6 5450.2 5497.1 5578.2 5961.3 6045.1 6060.7 6078.0 6101.6 6418.9 6500.1 6577.1 6583.5 6600.6 6578.9 6611.5 6614.3 6635.3 6636.5 6132.3 6221.5 6240.8 6302.5 6312.1 6893.7 6907.8 6917.1 7015.9 7016.5 6373.0 6597.0 6665.0 6668.4 6676.2 6565.5 6569.8 6572.0 6586.9 6587.1 6358.2 6496.2 6502.8 6528.2 6536.6 5704.7 6603.5 6627.4 6656.0 6672.0 4965.3 4983.4 5020.2 5027.3 5033.0 4379.8 4429.6 4450.6 4494.6 4500.5 6099.6 6139.4 6149.0 6159.1 6170.6 6509.5 6574.2 6574.5 6580.9 6592.1 6119.3 6121.6 6132.8 6158.9 6172.6 4842.0 5569.7 5661.8 5680.9 5770.7 6849.5 6872.3 6873.3 6879.9 6880.3 6599.3 6614.4 6619.4 6624.3 6732.7 6973.5 6980.7 7045.5 7049.9 7070.5 6608.6 6626.6 6654.2 6680.9 6695.5 6542.2 6638.0 6639.0 6641.4 6647.8 5324.3 6361.1 6419.4 6507.1 6564.6 6482.5 6484.1 6550.0 6581.4 6587.0 6486.8 6513.6 6543.9 6581.4 6594.1 6330.0 6436.0 6496.9 6507.0 6628.1 6276.9 6277.4 6281.3 6289.6 6293.9 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | [#1] ext.html Cycles:180 Average:41980.64 Median:35321.65 stddev:63796.10 (180.6%) stddev-sans-first:63900.39 08:58:49 INFO - PID 26428 | Values: 871.1 909.6 942.5 965.7 966.1 42225.4 43238.4 43440.3 43524.1 43830.0 39626.2 39968.2 40071.8 40121.8 40156.4 6727.0 6781.6 6831.1 6844.0 6858.0 6759.2 6777.7 6793.1 6814.7 6833.2 6782.8 6826.7 6834.9 6866.5 6868.9 6737.2 6787.5 6813.3 6823.8 6843.6 6263.1 6309.4 6311.0 6332.6 6339.4 35099.3 35309.5 35343.3 35430.3 35474.6 3374.1 3378.0 3395.8 3459.6 3492.7 32125.5 32710.0 32747.7 32781.5 32840.5 4955.1 4985.5 5010.9 5030.3 5124.3 205218.0 208589.0 209022.0 209044.0 209219.0 47651.3 50300.7 50728.0 50776.5 51044.2 52643.7 52701.5 52896.0 52914.0 52974.5 16667.3 16694.7 16819.5 16840.9 16879.0 13875.8 13966.8 14015.9 14016.9 14036.9 14398.4 14500.8 14527.4 14538.1 14622.6 5686.9 5789.0 5826.9 5829.5 5992.5 1055.1 1102.5 1102.6 1107.9 1110.2 25001.2 25088.4 25130.7 25201.2 25216.2 1199.3 1214.1 1220.3 1228.2 1237.3 13047.5 13184.7 13294.2 13312.5 13397.9 279607.0 279887.0 280594.0 280929.0 281450.0 55862.0 56041.7 56268.7 56564.0 56642.7 1472.2 1520.3 1535.7 1538.0 1567.4 24446.9 29761.0 29946.7 29985.0 30604.7 54206.5 54841.0 54932.7 55393.7 55401.4 239372.0 239726.0 240491.0 241227.0 242695.0 34546.7 34797.1 34960.7 37055.4 37303.3 41448.4 45656.5 45837.8 46034.8 46716.3 32053.0 32817.8 33053.8 33320.7 34902.7 34408.3 35333.8 35356.6 35555.9 35922.5 41394.6 41437.6 41759.4 41950.2 42078.4 34238.7 34440.7 34513.3 34526.5 34749.3 24953.3 25692.9 25768.5 25769.5 26263.9 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | [#2] jquery.html Cycles:180 Average:39510.89 Median:22201.28 stddev:92793.37 (418.0%) stddev-sans-first:93007.59 08:58:49 INFO - PID 26428 | Values: 556.2 561.6 567.3 574.5 594.7 22298.4 22895.8 22903.5 23014.8 23171.2 25664.0 26835.1 28363.0 28442.7 28502.9 6265.7 6445.1 6445.5 6447.5 6460.0 6325.4 6334.3 6339.4 6340.0 6344.5 4203.1 5147.0 6318.3 6848.9 6863.7 6822.2 6826.5 6848.4 6851.4 6875.0 6721.7 6725.4 6727.7 6730.1 6741.3 31533.8 33341.3 33692.2 33802.5 34178.1 2262.0 2308.4 2325.8 2329.6 2333.6 20412.2 20857.5 21089.4 21197.0 21206.8 2373.8 2465.5 2532.6 2563.1 2577.7 144616.3 148191.0 148278.3 150294.0 151307.0 21607.7 23164.4 23785.4 24420.6 24567.1 47898.5 47949.0 47979.8 48212.0 48506.3 11879.0 11938.5 12126.9 12220.1 12527.0 10091.1 10118.0 10138.9 10228.7 10231.2 11954.9 12081.6 12126.2 12189.8 12459.9 3340.7 3605.6 3964.5 4075.9 4121.9 1008.6 1011.9 1016.2 1058.7 1064.3 21179.0 21235.2 21464.9 21984.7 22104.1 1090.5 1097.7 1098.7 1110.6 1116.9 11703.2 11796.7 12130.0 12209.1 12315.5 545172.0 545304.0 554529.0 557774.0 559248.0 124318.4 128932.0 129660.0 130642.0 133342.0 1219.5 1221.7 1230.4 1239.9 1240.3 18206.0 19127.9 19267.6 19497.9 19523.7 59821.0 60114.1 61199.7 62866.4 63245.0 79749.0 79800.0 80006.0 81100.0 81242.6 21462.6 21758.6 22578.0 22584.3 22592.0 19692.4 20285.5 20545.5 23970.9 24791.4 18388.9 19052.5 20004.0 20197.8 20213.0 17182.9 17385.2 17430.1 17495.5 17941.7 19792.9 20042.4 20090.3 20211.6 20212.0 20000.1 20852.9 20955.4 21292.5 21466.1 19730.2 19816.7 19834.3 19856.5 20092.0 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | [#3] mootools.html Cycles:180 Average:9595.81 Median:2647.46 stddev:6745.77 (254.8%) stddev-sans-first:6736.75 08:58:49 INFO - PID 26428 | Values: 1425.3 1483.7 1500.9 1503.9 1505.9 14952.6 15672.2 15716.7 15742.4 15799.4 14734.4 15275.8 15927.5 15944.0 15997.8 2689.7 2758.6 2766.8 2776.8 2778.4 2685.6 2752.6 2758.7 2768.0 2772.1 2625.5 2685.8 2714.8 2716.7 2803.0 2679.6 2691.4 2699.1 2704.5 2707.5 2608.1 2645.9 2649.0 2657.8 2661.3 14915.9 15250.5 15251.2 15274.7 15337.8 8226.5 8493.2 8559.2 8561.5 8576.4 5172.3 5347.5 5423.2 5463.5 5477.6 1847.0 1854.4 1887.3 1920.8 1921.1 26866.5 26960.7 26998.2 27026.5 27035.0 6813.8 6970.8 7100.7 7144.6 7225.3 17920.9 17961.5 18009.0 18036.5 18043.4 7900.8 8314.0 8350.9 8368.0 8368.0 7534.7 7653.0 7810.7 7851.3 7893.7 5190.5 5297.8 5365.1 5405.6 5472.4 1566.0 1575.8 1575.9 1621.2 1631.7 904.6 920.6 935.6 944.7 957.1 8695.7 8810.6 8934.4 9297.3 9740.4 976.5 1019.5 1031.0 1042.0 1051.1 5216.0 5244.8 5254.8 5267.0 5360.7 19816.0 20418.6 20468.5 20687.8 20899.9 21034.5 21099.8 21549.6 21580.8 22065.2 11711.3 11868.3 12036.3 12198.3 12406.4 8027.2 8247.6 8379.0 8408.5 8635.5 18875.7 18930.3 19159.4 19314.2 19652.9 18719.6 18955.9 19690.2 19972.1 20137.6 12685.0 12904.7 13374.7 14067.2 14348.6 14185.1 14481.3 14547.4 14550.4 14606.3 11255.3 11333.3 11429.4 11593.6 11636.4 9835.4 10693.4 11227.9 11333.4 11606.4 10281.7 10333.9 10339.1 10365.0 10419.3 7301.6 7470.9 7616.2 7660.7 7726.2 7680.7 7730.8 7815.9 7826.1 7869.3 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | [#4] prototype.html Cycles:180 Average:5374.57 Median:5948.25 stddev:1537.37 (25.8%) stddev-sans-first:1496.93 08:58:49 INFO - PID 26428 | Values: 468.3 484.8 500.9 506.4 515.4 5870.1 5875.9 5923.6 5936.6 6061.1 5711.3 5862.6 5888.4 5936.7 5957.0 4651.1 4651.3 4659.0 4664.8 4681.8 4657.3 4672.9 4694.3 4703.2 4706.0 4472.6 4603.4 4627.2 4633.6 4655.3 4613.2 4640.6 4672.2 4708.0 4711.2 4229.8 4253.7 4255.6 4256.7 4256.8 5802.8 5884.5 5910.6 5916.9 5939.5 5492.8 5502.0 5521.6 5527.6 5546.2 6288.7 6311.8 6400.0 6408.8 6425.4 4771.8 4772.4 4802.2 4802.5 4806.7 6569.6 6596.5 6631.8 6682.8 6700.3 4909.3 4925.8 4953.8 4956.5 4957.7 4940.2 4942.2 4961.4 4980.6 4999.2 5491.9 5537.2 5537.5 5548.1 5567.7 6358.7 6367.4 6383.8 6399.5 6413.5 1716.0 1739.8 1746.3 1748.1 1749.2 1112.2 1123.8 1143.5 1149.8 1220.5 5866.4 5911.8 5966.9 5986.9 5988.5 6486.4 6526.2 6539.1 6543.9 6576.1 6010.5 6013.2 6053.9 6055.8 6059.1 3382.3 3388.9 3389.3 3390.2 3393.4 6633.6 6662.7 6687.0 6702.9 6833.3 6590.1 6600.5 6613.1 6677.9 6692.8 6777.6 6799.2 6860.6 6879.6 6912.3 6490.7 6501.6 6502.7 6524.5 6558.6 6338.7 6352.7 6413.8 6418.6 6451.8 6611.5 6696.6 6725.1 6768.8 6818.5 4871.8 4882.7 4902.0 4906.9 4912.3 6436.9 6439.6 6478.5 6519.9 6546.5 6244.8 6255.7 6332.6 6362.8 6393.0 6286.7 6288.2 6303.6 6329.8 6346.2 6206.9 6242.7 6282.5 6301.8 6316.3 5748.3 6259.9 6293.7 6335.2 6366.0 6160.8 6167.3 6172.4 6211.3 6262.6 08:58:49 INFO - PID 26428 | 08:58:49 INFO - PID 26428 | [#5] yui.html Cycles:180 Average:25440.93 Median:20052.75 stddev:35096.02 (175.0%) stddev-sans-first:35146.27 08:58:49 INFO - PID 26428 | Values: 943.2 945.8 957.8 962.0 970.9 17870.4 17994.6 18010.1 18984.2 19349.1 17321.7 17593.1 17734.1 17764.7 19361.7 1040.6 1045.5 1051.4 1054.4 1066.4 1093.5 1094.0 1094.3 1096.0 1097.9 1143.3 1146.0 1156.9 1157.1 1160.3 1063.4 1100.7 1101.8 1142.6 1148.0 806.2 806.9 807.4 810.7 811.0 19473.0 19743.2 19894.7 19930.6 19931.5 18729.2 19727.1 20069.7 20116.8 20137.1 16030.4 16071.9 16097.2 16112.8 16115.0 3451.8 3562.8 3570.7 3723.1 3729.0 128351.4 128512.0 134808.3 135387.0 137672.3 15513.4 16229.9 16231.9 16710.0 16736.7 30755.0 30783.0 31049.2 31184.5 31379.1 9051.4 9150.2 9164.4 9185.5 9212.5 4355.6 4460.3 4507.3 4568.1 4570.8 5127.9 5349.9 5352.2 5369.2 5384.1 1009.9 1038.1 1044.7 1059.1 1070.1 721.5 723.8 731.0 746.5 762.1 12382.3 12681.4 12710.7 12806.6 12985.8 720.2 731.7 737.0 744.6 751.3 5882.3 5909.6 5982.8 6031.6 6068.9 117119.0 120303.4 121928.4 125774.0 127874.0 105023.5 111088.4 112441.4 114293.4 116074.4 89456.6 89959.0 92287.0 93372.5 93504.1 12798.8 13021.0 13333.0 13421.0 13530.4 41327.0 44317.6 44934.3 46043.3 46662.8 57155.7 74214.6 79745.0 80218.0 80335.0 19913.4 20035.8 20724.6 20872.5 20918.8 21727.8 22360.6 22810.9 23753.5 23827.2 19899.2 20278.2 20427.9 20455.7 20939.9 19182.9 20522.1 20567.5 20735.9 21019.5 20572.9 21130.3 21310.0 21419.3 21651.0 14143.8 14193.3 14215.5 15008.2 15095.6 14921.0 15226.6 15422.4 15625.9 15677.4 08:58:49 INFO - PID 26428 | -------- Summary: end -------- 08:58:49 INFO - PID 26428 | 08:58:49 INFO - TEST-INFO | 26428: exit 0 08:58:49 INFO - TEST-OK | dromaeo_css | took 1108823ms 08:58:49 INFO - TEST-START | kraken 08:58:49 INFO - Initialising browser for kraken test... 08:58:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38513/getInfo.html -profile /tmp/tmpIx8QF9/profile 08:58:49 INFO - TEST-INFO | started process 26837 (/builds/slave/test/build/application/firefox/firefox http://localhost:38513/getInfo.html) 08:58:55 INFO - TEST-INFO | 26837: exit 0 08:58:55 INFO - Browser initialized. 08:58:55 INFO - Running cycle 1/1 for kraken test... 08:58:55 INFO - TEST-INFO | started process 27050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIx8QF9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:06 INFO - PID 27050 | RSS: Main: 160788480 08:59:06 INFO - PID 27050 | 08:59:09 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:10 INFO - PID 27050 | RSS: Main: 167161856 08:59:10 INFO - PID 27050 | 08:59:12 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-dft) 08:59:13 INFO - PID 27050 | RSS: Main: 167268352 08:59:13 INFO - PID 27050 | 08:59:16 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-fft) 08:59:16 INFO - PID 27050 | RSS: Main: 160899072 08:59:16 INFO - PID 27050 | 08:59:18 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38513/tests/kraken/driver.html?testName=audio-oscillator) 08:59:19 INFO - PID 27050 | RSS: Main: 162500608 08:59:19 INFO - PID 27050 | 08:59:21 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:21 INFO - PID 27050 | RSS: Main: 161746944 08:59:21 INFO - PID 27050 | 08:59:24 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38513/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:25 INFO - PID 27050 | RSS: Main: 163028992 08:59:25 INFO - PID 27050 | 08:59:28 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38513/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:29 INFO - PID 27050 | RSS: Main: 165490688 08:59:29 INFO - PID 27050 | 08:59:32 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38513/tests/kraken/driver.html?testName=json-parse-financial) 08:59:32 INFO - PID 27050 | RSS: Main: 166785024 08:59:32 INFO - PID 27050 | 08:59:34 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:34 INFO - PID 27050 | RSS: Main: 165621760 08:59:34 INFO - PID 27050 | 08:59:36 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:37 INFO - PID 27050 | RSS: Main: 165871616 08:59:37 INFO - PID 27050 | 08:59:39 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:39 INFO - PID 27050 | RSS: Main: 165752832 08:59:39 INFO - PID 27050 | 08:59:42 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:43 INFO - PID 27050 | RSS: Main: 165658624 08:59:43 INFO - PID 27050 | 08:59:45 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:46 INFO - PID 27050 | RSS: Main: 166285312 08:59:46 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | Cycle 1(1): loaded http://localhost:38513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38513/tests/kraken/driver.html?testName=ai-astar) 08:59:48 INFO - PID 27050 | RSS: Main: 168230912 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | __start_tp_report 08:59:48 INFO - PID 27050 | _x_x_mozilla_page_load 08:59:48 INFO - PID 27050 | _x_x_mozilla_page_load_details 08:59:48 INFO - PID 27050 | |i|pagename|runs| 08:59:48 INFO - PID 27050 | |0;ai-astar;107;97;106;108;108;106;106;110;110;109 08:59:48 INFO - PID 27050 | |1;audio-beat-detection;146;115;143;168;116;150;153;117;162;116 08:59:48 INFO - PID 27050 | |2;audio-dft;163;162;163;163;162;169;162;163;162;166 08:59:48 INFO - PID 27050 | |3;audio-fft;73;73;74;154;73;72;72;74;101;74 08:59:48 INFO - PID 27050 | |4;audio-oscillator;81;81;132;80;82;80;129;79;81;125 08:59:48 INFO - PID 27050 | |5;imaging-gaussian-blur;114;113;115;114;113;113;114;113;113;113 08:59:48 INFO - PID 27050 | |6;imaging-darkroom;149;147;147;147;147;147;148;150;147;149 08:59:48 INFO - PID 27050 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;95;94 08:59:48 INFO - PID 27050 | |8;json-parse-financial;52;47;52;50;47;47;49;46;48;46 08:59:48 INFO - PID 27050 | |9;json-stringify-tinderbox;54;54;54;55;54;54;53;54;54;53 08:59:48 INFO - PID 27050 | |10;stanford-crypto-aes;74;75;74;74;76;74;77;75;74;76 08:59:48 INFO - PID 27050 | |11;stanford-crypto-ccm;120;122;125;118;126;119;124;117;118;143 08:59:48 INFO - PID 27050 | |12;stanford-crypto-pbkdf2;178;177;179;175;179;167;167;180;168;182 08:59:48 INFO - PID 27050 | |13;stanford-crypto-sha256-iterative;63;70;62;63;62;63;62;61;61;60 08:59:48 INFO - PID 27050 | __end_tp_report 08:59:48 INFO - PID 27050 | __start_cc_report 08:59:48 INFO - PID 27050 | _x_x_mozilla_cycle_collect,846 08:59:48 INFO - PID 27050 | __end_cc_report 08:59:48 INFO - PID 27050 | __startTimestamp1500220788420__endTimestamp 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | ------- Summary: start ------- 08:59:48 INFO - PID 27050 | Number of tests: 14 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#0] ai-astar Cycles:10 Average:106.70 Median:108.50 stddev:3.74 (3.4%) stddev-sans-first:3.97 08:59:48 INFO - PID 27050 | Values: 107.0 97.0 106.0 108.0 108.0 106.0 106.0 110.0 110.0 109.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:148.00 stddev:20.73 (14.0%) stddev-sans-first:21.82 08:59:48 INFO - PID 27050 | Values: 146.0 115.0 143.0 168.0 116.0 150.0 153.0 117.0 162.0 116.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 08:59:48 INFO - PID 27050 | Values: 163.0 162.0 163.0 163.0 162.0 169.0 162.0 163.0 162.0 166.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#3] audio-fft Cycles:10 Average:84.00 Median:73.00 stddev:26.12 (35.8%) stddev-sans-first:27.40 08:59:48 INFO - PID 27050 | Values: 73.0 73.0 74.0 154.0 73.0 72.0 72.0 74.0 101.0 74.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:80.50 stddev:23.30 (28.9%) stddev-sans-first:24.16 08:59:48 INFO - PID 27050 | Values: 81.0 81.0 132.0 80.0 82.0 80.0 129.0 79.0 81.0 125.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:59:48 INFO - PID 27050 | Values: 114.0 113.0 115.0 114.0 113.0 113.0 114.0 113.0 113.0 113.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.14 (0.8%) stddev-sans-first:1.12 08:59:48 INFO - PID 27050 | Values: 149.0 147.0 147.0 147.0 147.0 147.0 148.0 150.0 147.0 149.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:59:48 INFO - PID 27050 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.50 stddev:2.27 (4.7%) stddev-sans-first:2.00 08:59:48 INFO - PID 27050 | Values: 52.0 47.0 52.0 50.0 47.0 47.0 49.0 46.0 48.0 46.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 08:59:48 INFO - PID 27050 | Values: 54.0 54.0 54.0 55.0 54.0 54.0 53.0 54.0 54.0 53.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.10 (1.5%) stddev-sans-first:1.12 08:59:48 INFO - PID 27050 | Values: 74.0 75.0 74.0 74.0 76.0 74.0 77.0 75.0 74.0 76.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.00 stddev:7.64 (6.2%) stddev-sans-first:8.02 08:59:48 INFO - PID 27050 | Values: 120.0 122.0 125.0 118.0 126.0 119.0 124.0 117.0 118.0 143.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:178.50 stddev:5.73 (3.2%) stddev-sans-first:5.99 08:59:48 INFO - PID 27050 | Values: 178.0 177.0 179.0 175.0 179.0 167.0 167.0 180.0 168.0 182.0 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.75 (4.4%) stddev-sans-first:2.92 08:59:48 INFO - PID 27050 | Values: 63.0 70.0 62.0 63.0 62.0 63.0 62.0 61.0 61.0 60.0 08:59:48 INFO - PID 27050 | -------- Summary: end -------- 08:59:48 INFO - PID 27050 | 08:59:48 INFO - PID 27050 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:59:49 INFO - TEST-INFO | 27050: exit 0 08:59:49 INFO - TEST-OK | kraken | took 59468ms 08:59:49 INFO - SUITE-END | took 1168s 08:59:49 INFO - Completed test suite (00:19:28) 08:59:49 INFO - javascript benchmark 08:59:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8845.757717514525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3378.493226016099, 3384.306217225469, 3407.3696366172244, 3420.640832712564, 3423.8801641942523, 6095.634261944281, 6242.781502647403, 6258.561900666955, 6281.183446151994, 6283.560150789435, 6067.908981365283, 6140.8464788380315, 6141.6622085785375, 6155.6306621602735, 6166.660833654148, 5383.273258110164, 5407.270018547505, 5421.756020979065, 5430.0, 5449.782008719647, 5404.621676482648, 5440.211169380437, 5450.5639548836, 5462.262594549725, 5500.257465242201, 5457.399686034533, 5459.535939445152, 5476.58925580581, 5495.53287970523, 5495.890082198373, 5412.052890744143, 5424.945750542503, 5446.482584154499, 5446.91829622556, 5462.781488740446, 5373.731313434352, 5421.620486565942, 5450.236966824647, 5497.147942068986, 5578.163275508666, 5961.314448838396, 6045.063015232646, 6060.727267272983, 6078.0, 6101.572889897709, 6418.93581064188, 6500.089987401768, 6577.112089867855, 6583.473322134218, 6600.60396376219, 6578.868422631521, 6611.504137189682, 6614.338566143395, 6635.3032931541975, 6636.469082473391, 6132.264128304588, 6221.533384996098, 6240.781572644981, 6302.4958003359625, 6312.053192021188, 6893.724251030003, 6907.756603811362, 6917.066196063568, 7015.8596828063155, 7016.5088443808445, 6373.044043393528, 6597.043428702811, 6665.0, 6668.366505182, 6676.232233293136, 6565.474762019027, 6569.80290591283, 6572.0, 6586.934130658632, 6587.110740050032, 6358.173437453194, 6496.187976502937, 6502.804915852532, 6528.151340325728, 6536.575122617015, 5704.674337422438, 6603.537752357289, 6627.403533681895, 6656.034874943106, 6672.0, 4965.255211718271, 4983.401991761012, 5020.171671674133, 5027.296178535008, 5033.0437216929395, 4379.759113248738, 4429.623482004002, 4450.554944505524, 4494.5730155635165, 4500.527444618333, 6099.603525770811, 6139.416755408229, 6149.016157414792, 6159.1069294951985, 6170.56806023583, 6509.479241660656, 6574.243961944342, 6574.506911981621, 6580.934190658128, 6592.077109204715, 6119.265688117454, 6121.632702037892, 6132.78535251264, 6158.907616385758, 6172.598781079216, 4842.0, 5569.721513924287, 5661.801836935688, 5680.943190568124, 5770.740316685759, 6849.486288528281, 6872.278410766898, 6873.278305777922, 6879.89680154798, 6880.277570854988, 6599.340065993459, 6614.437772789367, 6619.404253617197, 6624.27133015368, 6732.663366831737, 6973.546719463218, 6980.650967451708, 7045.506814523139, 7049.894251586333, 7070.469714771516, 6608.636524991171, 6626.635535045426, 6654.234763002317, 6680.899786503303, 6695.531312808057, 6542.182227221598, 6638.037484564615, 6638.966805165944, 6641.369069938348, 6647.800565983028, 5324.307839980777, 6361.077643741724, 6419.390157934989, 6507.089007539043, 6564.606123632598, 6482.546221764431, 6484.059811327237, 6550.017497375432, 6581.3747693969, 6586.967065164644, 6486.772962946275, 6513.576617519846, 6543.934560654333, 6581.407673309425, 6594.076829243813, 6330.0, 6435.967820160869, 6496.870062598627, 6507.023946408077, 6628.105205797156, 6276.9372306276355, 6277.435030847246, 6281.277653069956, 6289.622622642656, 6293.937060629335], "value": 6041.669517151946, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.146944594661, 909.5861383070708, 942.5475771629617, 965.6861520005991, 966.1304825656912, 42225.366619500695, 43238.35142472858, 43440.348394774104, 43524.12951740963, 43830.0, 39626.20747585054, 39968.200635987334, 40071.799641001824, 40121.799391003005, 40156.39765403514, 6727.024581435689, 6781.559198652097, 6831.1119554457855, 6843.965780171092, 6858.0, 6759.155105611799, 6777.69500372482, 6793.116894803668, 6814.6933387997415, 6833.180018397799, 6782.830429239284, 6826.69279882404, 6834.897476537856, 6866.485013623973, 6868.931310686904, 6737.157855268091, 6787.4909381796315, 6813.250542440328, 6823.795286141423, 6843.62360070196, 6263.091851681481, 6309.3690630937, 6311.0, 6332.556721029529, 6339.36606339367, 35099.29801403983, 35309.470357944396, 35343.29313413717, 35430.29139417223, 35474.645253547395, 3374.122728090714, 3377.9831100844585, 3395.813230272334, 3459.550258466383, 3492.668196521352, 32125.51811722826, 32710.0, 32747.6725232747, 32781.508277375855, 32840.50739238913, 4955.1328517509655, 4985.501449855022, 5010.874728131789, 5030.2957585938, 5124.333836601218, 205218.0, 208589.0, 209022.0, 209043.95478022666, 209219.0, 47651.285230721565, 50300.74849625801, 50728.0, 50776.492235077916, 51044.23433648498, 52643.73678131661, 52701.472985269655, 52896.0, 52914.0, 52974.470255297725, 16667.33330666784, 16694.749578756328, 16819.495415137564, 16840.915795420944, 16878.987260764392, 13875.791863122062, 13966.790498142536, 14015.85984140166, 14016.85983140176, 14036.859631403759, 14398.42406303757, 14500.782488262685, 14527.418903243963, 14538.055026423248, 14622.610851969046, 5686.943130568724, 5788.9710551447815, 5826.883462330815, 5829.533637309005, 5992.490638295706, 1055.1137044882182, 1102.459794700607, 1102.5755084292605, 1107.9224454288124, 1110.2339385823757, 25001.249962501155, 25088.372790680012, 25130.748692513207, 25201.24396268115, 25216.24351269428, 1199.322382853685, 1214.09549885336, 1220.2617416462913, 1228.2078059651474, 1237.2514628649717, 13047.478100875858, 13184.670383240496, 13294.202347858965, 13312.467501300032, 13397.933010334886, 279607.0, 279887.0, 280594.0, 280929.0, 281450.0, 55862.0, 56041.7197914016, 56268.718656406454, 56564.0, 56642.716786415804, 1472.1902953375816, 1520.2854658310798, 1535.7466018107111, 1537.961550961235, 1567.388718399825, 24446.877765611058, 29761.0, 29946.70053299439, 29985.0, 30604.693953060185, 54206.45793542014, 54841.0, 54932.72533637306, 55393.72303138459, 55401.44598554124, 239372.0, 239726.0, 240491.0, 241227.0, 242695.0, 34546.65453345434, 34797.13007174841, 34960.650393496755, 37055.444168338036, 37303.253934920605, 41448.37827432651, 45656.54343456523, 45837.770811147064, 46034.76982615065, 46716.299255510516, 32053.0, 32817.835910821246, 33053.834730826195, 33320.666793332726, 34902.65097348994, 34408.311833763684, 35333.823330883184, 35356.64643353636, 35555.93332200038, 35922.46116308205, 41394.58605413907, 41437.58562414337, 41759.373609395276, 41950.16099677928, 42078.36882446705, 34238.657613423544, 34440.655593444746, 34513.30973380568, 34526.48210276798, 34749.30501389907, 24953.251402457954, 25692.87153564295, 25768.484630306913, 25769.484610308064, 26263.868680656473], "value": 17937.137035353564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.1685280505643, 561.5703986450363, 567.3107174782639, 574.5145352177411, 594.6729298885613, 22298.442538936535, 22895.771042289573, 22903.541929161405, 23014.769852301513, 23171.18900838471, 25664.0, 26835.060772872952, 28363.0, 28442.715572844267, 28502.857485712542, 6265.7493700251935, 6445.129907462479, 6445.51658625605, 6447.54867159299, 6459.967700161493, 6325.399087086719, 6334.271558770754, 6339.397757213057, 6340.017297318923, 6344.4607208387115, 4203.096334288128, 5146.974265128669, 6318.336574659664, 6848.931510684879, 6863.725450981955, 6822.215445223788, 6826.4538836892925, 6848.417884479825, 6851.38337549618, 6875.037494750739, 6721.663916804189, 6725.361090696376, 6727.697253623599, 6730.125083739083, 6741.3258674132685, 31533.84233078843, 33341.333173336396, 33692.15769605755, 33802.49296260558, 34178.145546361295, 2262.049939025613, 2308.445972966476, 2325.755795641467, 2329.580675478413, 2333.5916214662366, 20412.183512659474, 20857.478563035893, 21089.3673189803, 21197.046132924057, 21206.787932120635, 2373.8457000294925, 2465.469923966356, 2532.6327682485935, 2563.115725074846, 2577.7164511903675, 144616.27691861472, 148191.0, 148278.25860870734, 150294.0, 151307.0, 21607.67588486174, 23164.420889477897, 23785.405364866016, 24420.63369049466, 24567.14015009466, 47898.5210147901, 47949.0, 47979.76010119997, 48212.0, 48506.27240591394, 11879.0, 11938.462769175409, 12126.878731212752, 12220.1445898788, 12527.0, 10091.142252908585, 10118.0, 10138.949305253427, 10228.744281393025, 10231.232657550714, 11954.940225298818, 12081.637550873313, 12126.211796233216, 12189.756204875854, 12459.93770031144, 3340.716039136652, 3605.603383627851, 3964.4736776341315, 4075.8847646203826, 4121.855735049259, 1008.6268080810147, 1011.9190464762802, 1016.1768967136643, 1058.6771034834296, 1064.3401091323428, 21179.0, 21235.150593976377, 21464.939705225486, 21984.670229946565, 22104.115835366407, 1090.4711215060688, 1097.665212110314, 1098.6594155811724, 1110.5557776889148, 1116.8827273136367, 11703.23928944616, 11796.705082372837, 12130.0, 12209.084318676134, 12315.50737970489, 545172.0, 545304.0, 554529.0, 557774.0, 559248.0, 124318.37840810738, 128932.0, 129660.0, 130642.0, 133342.0, 1219.4817701446484, 1221.7190046289224, 1230.4155526125019, 1239.900807935363, 1240.2806372304221, 18206.0, 19127.904360478107, 19267.614647706687, 19497.902510487358, 19523.70714439256, 59821.0, 60114.09828852483, 61199.69400153149, 62866.371336287884, 63245.0, 79749.0, 79800.0, 80006.0, 81100.0, 81242.59378703068, 21462.570748585254, 21758.56482870302, 22578.0, 22584.322470325915, 22592.0, 19692.40922772319, 20285.49286267855, 20545.48636284105, 23970.88014559916, 24791.380215494755, 18388.908055459637, 19052.523686907938, 20004.0, 20197.79802202018, 20213.0, 17182.914085429493, 17385.21766520535, 17430.128493575525, 17495.475135745946, 17941.730874037163, 19792.90103549473, 20042.39872803818, 20090.296839610543, 20211.59576808485, 20212.0, 20000.099995500528, 20852.895735521226, 20955.37133885986, 21292.467688307916, 21466.14135434565, 19730.210791568177, 19816.70274945848, 19834.305799296955, 19856.503587409854, 20092.0], "value": 13524.645989493056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.2517428350116, 1483.6958423523165, 1500.9399624015036, 1503.8872084593659, 1505.872000879925, 14952.626184345398, 15672.216389180552, 15716.685666286681, 15742.370305187778, 15799.447019354297, 14734.410623575071, 15275.770863437057, 15927.522174334788, 15944.0, 15997.84002159978, 2689.744474274946, 2758.5724212747054, 2766.7509924106826, 2776.847273399962, 2778.4304217635436, 2685.6374389457465, 2752.587111933216, 2758.7379198976164, 2767.958480622792, 2772.0575004498464, 2625.514279858223, 2685.8388496690163, 2714.7556719895206, 2716.7283271672873, 2803.032953630994, 2679.624852520649, 2691.4078902641386, 2699.1092939329974, 2704.4591081783724, 2707.5126477233994, 2608.113241497881, 2645.933851653705, 2648.9867550662316, 2657.827241229314, 2661.2548486423834, 14915.850841491554, 15250.542483725507, 15251.23743812805, 15274.694506109927, 15337.846621533754, 8226.506409615442, 8493.235608795238, 8559.186877246651, 8561.486310821309, 8576.39965202436, 5172.27588137661, 5347.54545863602, 5423.159410291411, 5463.480969307949, 5477.561795056426, 1847.0288878910317, 1854.4158590044092, 1887.2545344588948, 1920.817522335376, 1921.1162865082078, 26866.462670746474, 26960.73039269602, 26998.190054298404, 27026.459470810474, 27035.0, 6813.761518346933, 6970.825729356807, 7100.68046937889, 7144.607046612487, 7225.277472252733, 17920.9103954482, 17961.461156165336, 18009.0, 18036.458906232834, 18043.368482103062, 7900.841983160304, 8314.0, 8350.874736878952, 8367.95816020916, 8367.99584049918, 7534.736284230025, 7652.961735191399, 7810.687572497037, 7851.293383595504, 7893.684252629945, 5190.506901844319, 5297.761600727977, 5365.061114304981, 5405.648632838853, 5472.425395333512, 1565.9921700391426, 1575.8109026916613, 1575.8581727644337, 1621.1894052973514, 1631.6655085707403, 904.5929331800716, 920.5673333533229, 935.5930170375908, 944.730751735752, 957.1194501059042, 8695.739127826175, 8810.647574097093, 8934.41926274803, 9297.30270229722, 9740.36687615317, 976.4629453800381, 1019.4545917934018, 1031.041131747482, 1042.0361165921493, 1051.1380667852288, 5215.973920130375, 5244.819915518978, 5254.7635356409055, 5266.999270138738, 5360.705161216092, 19816.0, 20418.59162816765, 20468.488287792923, 20687.793122068586, 20899.895500522704, 21034.47413814667, 21099.78900210978, 21549.569008620052, 21580.784192158193, 22065.227717029826, 11711.297322160697, 11868.347240901661, 12036.277823330629, 12198.329091899854, 12406.441710123067, 8027.237412445808, 8247.628856701584, 8378.958105209435, 8408.495490270603, 8635.481871087755, 18875.716864247323, 18930.337438189596, 19159.425217243504, 19314.227430902607, 19652.901735491803, 18719.625607487502, 18955.90522047381, 19690.21239150418, 19972.10125544383, 20137.59724805525, 12685.0, 12904.741905162033, 13374.732505350034, 14067.155970641794, 14348.641283967985, 14185.077969931921, 14481.275936203358, 14547.418103276173, 14550.417983280973, 14606.269686515845, 11255.268407553483, 11333.320000799979, 11429.428528573704, 11593.594224202112, 11636.36000020007, 9835.360701554377, 10693.358398496115, 11227.887721122685, 11333.376664283544, 11606.419679015846, 10281.74295642615, 10333.948330258301, 10339.121174700234, 10365.0, 10419.322744021614, 7301.598412087386, 7470.925290747023, 7616.162222155448, 7660.73187438437, 7726.227377262228, 7680.692772289046, 7730.845383092419, 7815.921840781747, 7826.139124696393, 7869.331106855752], "value": 6883.262145815821, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.29755366949576, 484.78669385470414, 500.85975926740514, 506.4201489294758, 515.3558052434455, 5870.148828419882, 5875.88248235035, 5923.6149650272755, 5936.58443908926, 6061.1211374350805, 5711.2575365202565, 5862.560307976897, 5888.381719919411, 5936.7031648417515, 5956.970215148918, 4651.1162879053045, 4651.279051746985, 4658.998315362196, 4664.8134074637055, 4681.83613573525, 4657.347971284023, 4672.883177920562, 4694.319323698061, 4703.15343238217, 4706.0, 4472.597466228039, 4603.3785438965815, 4627.236505976527, 4633.6061434778085, 4655.301704744282, 4613.1696294666945, 4640.628749700016, 4672.229082201433, 4707.95292047082, 4711.24620060792, 4229.809658565341, 4253.723507971972, 4255.6169944705125, 4256.701705979675, 4256.829726810924, 5802.82591522255, 5884.529237660977, 5910.586258961875, 5916.852078698024, 5939.524838012949, 5492.835214943558, 5502.0, 5521.641093328921, 5527.640703354269, 5546.195801608785, 6288.654124023177, 6311.810645680637, 6400.0, 6408.839779005515, 6425.357464253584, 4771.8091276348905, 4772.42730872294, 4802.207635740098, 4802.543758342952, 4806.687565308243, 6569.57297775643, 6596.472282217459, 6631.767888123893, 6682.766103186365, 6700.329967003309, 4909.3126962225315, 4925.798231149782, 4953.826616068421, 4956.4547899731, 4957.677750946249, 4940.2342636891335, 4942.159832828428, 4961.3798275215595, 4980.626453016038, 4999.225120106316, 5491.9290738306445, 5537.224788529609, 5537.473939975695, 5548.140038294071, 5567.66594004361, 6358.713857876407, 6367.395097465826, 6383.808485745435, 6399.456046236029, 6413.518986076063, 1715.9571010724583, 1739.773829402195, 1746.3451205797826, 1748.1259370314842, 1749.1691446562781, 1112.1603189591967, 1123.775244951013, 1143.5140065472142, 1149.7528031473107, 1220.4934951994824, 5866.384029676822, 5911.822645320647, 5966.880662386815, 5986.880262394728, 5988.461038506555, 6486.416222539994, 6526.216853977553, 6539.149910511698, 6543.9202531582705, 6576.1122248496795, 6010.4891084258325, 6013.188219590387, 6053.878922421527, 6055.757769689163, 6059.091136329498, 3382.3235352929514, 3388.8983330500123, 3389.3053473263367, 3390.1524618845287, 3393.355262500117, 6633.568818026813, 6662.669264977803, 6686.957434367351, 6702.865942681216, 6833.3166683331265, 6590.143281373391, 6600.53796234259, 6613.14029176204, 6677.933220667731, 6692.799216023527, 6777.559458635173, 6799.218089919624, 6860.588364698134, 6879.58722476653, 6912.271932016995, 6490.740370385131, 6501.6424096673245, 6502.73989040452, 6524.4780417565535, 6558.573692709959, 6338.651374174465, 6352.745890164341, 6413.839654008687, 6418.582792118497, 6451.774187903401, 6611.504137189634, 6696.631685257357, 6725.092112564741, 6768.796936091925, 6818.522703410714, 4871.780769865293, 4882.731449770296, 4901.975490122527, 4906.926396104132, 4912.263160525807, 6436.9034464484, 6439.581427207217, 6478.481721462366, 6519.902201467076, 6546.476281897532, 6244.750209991549, 6255.749770009149, 6332.588381755171, 6362.840928976812, 6393.0, 6286.685665716787, 6288.151099601495, 6303.573124347067, 6329.778457753957, 6346.238451385863, 6206.937930620636, 6242.656653883898, 6282.465990390868, 6301.779437719658, 6316.305206427382, 5748.252727145445, 6259.906101408392, 6293.716782744696, 6335.180844524327, 6366.0, 6160.751325766153, 6167.259928808572, 6172.4136207060255, 6211.316645269528, 6262.624242545462], "value": 4919.807201096871, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.2029934705176, 945.7516078776015, 957.8228027814855, 961.9855702164465, 970.9271255262935, 17870.374536891195, 17994.550136246602, 18010.09949502526, 18984.240630374785, 19349.129289181987, 17321.7401738974, 17593.120343982813, 17734.113294335264, 17764.733528997043, 19361.709574356395, 1040.5525623981666, 1045.5347370420166, 1051.395447617623, 1054.4042615922017, 1066.4401189375562, 1093.518851705251, 1094.026316578246, 1094.316052467208, 1095.956161753529, 1097.9341239525613, 1143.3082984794205, 1145.9770804583902, 1156.9016633586155, 1157.0801213035616, 1160.3038177093717, 1063.383237722123, 1100.7358234023777, 1101.7796440711809, 1142.5658249865082, 1148.0299147220585, 806.1978331560135, 806.8668669669497, 807.4428644235459, 810.7324582887633, 810.9918900810975, 19473.0, 19743.21027158912, 19894.70157947632, 19930.601387972158, 19931.50171245716, 18729.15718792644, 19727.112279947294, 20069.698954515694, 20116.798832011784, 20137.09383077765, 16030.358785648677, 16071.919640401724, 16097.195140243059, 16112.75830862538, 16115.0, 3451.775634583744, 3562.8040457774814, 3570.7143428525656, 3723.1436769543157, 3728.981355093207, 128351.35824320912, 128512.0, 134808.3259583696, 135387.0, 137672.31163844216, 15513.379464821506, 16229.918850405673, 16231.918840405722, 16710.0, 16736.665266694843, 30755.0, 30783.0, 31049.223769405944, 31184.53223201654, 31379.05862824073, 9051.411658242194, 9150.222231110298, 9164.404313719588, 9185.494797786187, 9212.493312867857, 4355.586219309161, 4460.330950357407, 4507.256302710016, 4568.109218702388, 4570.771461426915, 5127.948720512747, 5349.919751203735, 5352.170413585901, 5369.19462080691, 5384.0847056000575, 1009.8939611340703, 1038.0501840815568, 1044.6604853422668, 1059.0838924330399, 1070.117153348475, 721.4733244731375, 723.8237863471858, 730.9597972111478, 746.4550877859193, 762.142589586715, 12382.318972456422, 12681.365931703378, 12710.745785084246, 12806.551770687982, 12985.805212921814, 720.2401466452837, 731.7036600176937, 737.0, 744.6016381236012, 751.2600088912417, 5882.264716910387, 5909.615874968199, 5982.790602328984, 6031.638101713911, 6068.878622427526, 117119.0, 120303.39848300703, 121928.39035804765, 125774.0, 127874.0, 105023.4748826251, 111088.44455777669, 112441.43779281215, 114293.42853285681, 116074.41962790133, 89456.5527172373, 89959.0, 92287.0, 93372.53313733524, 93504.06495934953, 12798.808017879925, 13021.0, 13333.0, 13421.0, 13530.391132399263, 41327.0, 44317.556824432635, 44934.3259851109, 46043.30935036044, 46662.76668616635, 57155.71422142863, 74214.62892685719, 79745.00637484109, 80218.0, 80335.0, 19913.402597922086, 20035.799642003392, 20724.58550828945, 20872.47818804542, 20918.790812091684, 21727.782722172575, 22360.552788944457, 22810.88594557083, 23753.52492950166, 23827.166049188196, 19899.204031839145, 20278.188872444938, 20427.897860510602, 20455.69316460284, 20939.8953005234, 19182.904085479484, 20522.07650655754, 20567.485812854797, 20735.8963205183, 21019.474513137295, 20572.897135514228, 21130.260440884496, 21310.0, 21419.250326238507, 21651.0, 14143.787843182567, 14193.290335482978, 14215.50245741394, 15008.174550399834, 15095.622609434413, 14920.955533112578, 15226.619334516725, 15422.383104675688, 15625.921870390575, 15677.372905083668], "value": 9651.656599465274, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 97.0, 106.0, 108.0, 108.0, 106.0, 106.0, 110.0, 110.0, 109.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 143.0, 168.0, 116.0, 150.0, 153.0, 117.0, 162.0, 116.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 162.0, 169.0, 162.0, 163.0, 162.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 154.0, 73.0, 72.0, 72.0, 74.0, 101.0, 74.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 132.0, 80.0, 82.0, 80.0, 129.0, 79.0, 81.0, 125.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 150.0, 147.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 47.0, 52.0, 50.0, 47.0, 47.0, 49.0, 46.0, 48.0, 46.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 53.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 74.0, 76.0, 74.0, 77.0, 75.0, 74.0, 76.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 125.0, 118.0, 126.0, 119.0, 124.0, 117.0, 118.0, 143.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 179.0, 175.0, 179.0, 167.0, 167.0, 180.0, 168.0, 182.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 62.0, 63.0, 62.0, 63.0, 62.0, 61.0, 61.0, 60.0], "value": 62.7, "unit": "score"}]}]} 08:59:49 INFO - Return code: 0 08:59:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:49 INFO - # TBPL SUCCESS # 08:59:49 INFO - Running post-action listener: _package_coverage_data 08:59:49 INFO - Running post-action listener: _resource_record_post_action 08:59:49 INFO - [mozharness: 2017-07-16 15:59:49.730910Z] Finished run-tests step (success) 08:59:49 INFO - Running post-run listener: _resource_record_post_run 08:59:49 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 441552896; Read time: 72; Write time: 290328 08:59:49 INFO - TinderboxPrint: CPU usage
13.0% 08:59:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 72 08:59:49 INFO - TinderboxPrint: I/O write bytes / time
441,552,896 / 290,328 08:59:49 INFO - TinderboxPrint: CPU idle
8,232.2 (87.0%) 08:59:49 INFO - TinderboxPrint: CPU user
1,186.2 (12.5%) 08:59:49 INFO - TinderboxPrint: Swap in / out
0 / 0 08:59:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116350976; Read time: 56; Write time: 90560 08:59:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:59:49 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 325201920; Read time: 0; Write time: 199768 08:59:50 INFO - Running post-run listener: _upload_blobber_files 08:59:50 INFO - Blob upload gear active. 08:59:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:50 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 08:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:59:50 INFO - Traceback (most recent call last): 08:59:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:59:50 INFO - main() 08:59:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:59:50 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:59:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:59:50 INFO - return set(response.json().get('whitelist', [])) 08:59:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:59:50 INFO - return json.loads(self.text or self.content, **kwargs) 08:59:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:59:50 INFO - return _default_decoder.decode(s) 08:59:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:59:50 INFO - obj, end = self.raw_decode(s) 08:59:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:59:50 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:59:50 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:59:50 ERROR - Return code: 1 08:59:50 INFO - Setting buildbot property blobber_files to {} 08:59:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:59:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:59:50 INFO - Contents: 08:59:50 INFO - blobber_files:{} 08:59:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:59:50 INFO - Copying logs to upload dir... 08:59:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:59:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.975436 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-07-16 08:59:50.627938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:59:50.632984) ========= 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=03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/G6r6NslBSzWKbo6uodt9KQ/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 08:59:50.686557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:59:50.686885) ========= 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=03627c79f6bb3d1578c4a402000001ba-1500199823.896711-133806269 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 08:59:50.736398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:59:50.739736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 08:59:50.740029) ========= ========= Total master_lag: 0.19 =========