builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1500295680.67 results: success (0) revision: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.671023) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.671454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.671728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.739030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.742288) ========= 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=7de08804244eb36560b44971000001c3-1500288307.299593-304713271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 05:48:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-07-17 05:48:01 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103406 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.875740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.876018) ========= 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=7de08804244eb36560b44971000001c3-1500288307.299593-304713271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018265 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.932975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 05:48:00.936315) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d43779e278d2e4d3e21dba2fcb585a3bf4b1288e --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 d43779e278d2e4d3e21dba2fcb585a3bf4b1288e --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=7de08804244eb36560b44971000001c3-1500288307.299593-304713271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 05:48:01,178 truncating revision to first 12 chars 2017-07-17 05:48:01,178 Setting DEBUG logging. 2017-07-17 05:48:01,178 attempt 1/10 2017-07-17 05:48:01,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d43779e278d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 05:48:02,231 unpacking tar archive at: mozilla-central-d43779e278d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 05:48:02.315044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.318363) ========= script_repo_revision: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.318721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.318984) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.327522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-17 05:48:02.327786) ========= /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=7de08804244eb36560b44971000001c3-1500288307.299593-304713271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:02 INFO - MultiFileLogger online at 20170717 05:48:02 in /builds/slave/test 05:48:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:48:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:02 INFO - {'append_to_log': False, 05:48:02 INFO - 'base_work_dir': '/builds/slave/test', 05:48:02 INFO - 'blob_upload_branch': 'Firefox', 05:48:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:02 INFO - 'branch': 'Firefox', 05:48:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:02 INFO - 'code_coverage': False, 05:48:02 INFO - 'config_files': ('talos/linux_config.py',), 05:48:02 INFO - 'default_actions': ('clobber', 05:48:02 INFO - 'read-buildbot-config', 05:48:02 INFO - 'download-and-extract', 05:48:02 INFO - 'populate-webroot', 05:48:02 INFO - 'create-virtualenv', 05:48:02 INFO - 'install', 05:48:02 INFO - 'setup-mitmproxy', 05:48:02 INFO - 'run-tests'), 05:48:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:02 INFO - 'disable_ccov_upload': False, 05:48:02 INFO - 'download_minidump_stackwalk': True, 05:48:02 INFO - 'download_symbols': 'ondemand', 05:48:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:02 INFO - 'gecko_profile': False, 05:48:02 INFO - 'gecko_profile_interval': 0, 05:48:02 INFO - 'installer_path': 'installer.exe', 05:48:02 INFO - 'log_level': 'info', 05:48:02 INFO - 'log_name': 'talos', 05:48:02 INFO - 'log_to_console': True, 05:48:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:02 INFO - 'opt_config_files': (), 05:48:02 INFO - 'pip_index': False, 05:48:02 INFO - 'suite': 'dromaeojs-e10s', 05:48:02 INFO - 'system_bits': '32', 05:48:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:02 INFO - 'title': 'talos-linux64-ix-003', 05:48:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:02 INFO - 'use_talos_json': True, 05:48:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:02 INFO - 'work_dir': 'build'} 05:48:02 INFO - [mozharness: 2017-07-17 12:48:02.680556Z] Running clobber step. 05:48:02 INFO - Running pre-action listener: _resource_record_pre_action 05:48:02 INFO - Running main action method: clobber 05:48:02 INFO - rmtree: /builds/slave/test/build 05:48:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:04 INFO - Running post-action listener: _resource_record_post_action 05:48:04 INFO - [mozharness: 2017-07-17 12:48:04.211089Z] Finished clobber step (success) 05:48:04 INFO - [mozharness: 2017-07-17 12:48:04.211189Z] Running read-buildbot-config step. 05:48:04 INFO - Running pre-action listener: _resource_record_pre_action 05:48:04 INFO - Running main action method: read_buildbot_config 05:48:04 INFO - Using buildbot properties: 05:48:04 INFO - { 05:48:04 INFO - "project": "", 05:48:04 INFO - "product": "firefox", 05:48:04 INFO - "who": "archaeopteryx@coole-files.de", 05:48:04 INFO - "installer_path": "public/build/target.tar.bz2", 05:48:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:48:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:48:04 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:48:04 INFO - "stage_platform": "linux64-stylo", 05:48:04 INFO - "basedir": "/builds/slave/test", 05:48:04 INFO - "buildnumber": 31, 05:48:04 INFO - "platform": "ubuntu64_hw_stylo", 05:48:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:48:04 INFO - "slavebuilddir": "test", 05:48:04 INFO - "taskId": "VQ0j8664S7mbE4fsZhowqA", 05:48:04 INFO - "branch": "mozilla-central", 05:48:04 INFO - "script_repo_revision": "production", 05:48:04 INFO - "revision": "d43779e278d2e4d3e21dba2fcb585a3bf4b1288e", 05:48:04 INFO - "slavename": "talos-linux64-ix-003", 05:48:04 INFO - "repo_path": "mozilla-central" 05:48:04 INFO - } 05:48:04 INFO - Finding installer, test and symbols from parent task. 05:48:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQ0j8664S7mbE4fsZhowqA'}, attempt #1 05:48:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VQ0j8664S7mbE4fsZhowqA'}, attempt #1 05:48:05 INFO - Task dependencies: AcKXipBCQoSWPd6GQSLflg 05:48:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg'}, attempt #1 05:48:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/test_packages.json 05:48:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip 05:48:05 INFO - Running post-action listener: _resource_record_post_action 05:48:05 INFO - [mozharness: 2017-07-17 12:48:05.562060Z] Finished read-buildbot-config step (success) 05:48:05 INFO - [mozharness: 2017-07-17 12:48:05.562276Z] Running download-and-extract step. 05:48:05 INFO - Running pre-action listener: _resource_record_pre_action 05:48:05 INFO - Running main action method: download_and_extract 05:48:05 INFO - mkdir: /builds/slave/test/build/tests 05:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:05 INFO - trying https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.test_packages.json 05:48:05 INFO - Downloading https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:48:06 INFO - Downloaded 989 bytes. 05:48:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:48:06 INFO - Using the following test package requirements: 05:48:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:48:06 INFO - u'common': [u'target.common.tests.zip'], 05:48:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:48:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:48:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:48:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:48:06 INFO - u'mozbase': [u'target.common.tests.zip'], 05:48:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:48:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:48:06 INFO - u'web-platform': [u'target.common.tests.zip', 05:48:06 INFO - u'target.web-platform.tests.tar.gz'], 05:48:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:48:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip 05:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip into memory 05:48:09 INFO - Content-Length response header: 72769128 05:48:09 INFO - Bytes received: 72769128 05:48:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:48:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip 05:48:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:48:19 INFO - Fetch https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip into memory 05:48:21 INFO - Content-Length response header: 72769128 05:48:21 INFO - Bytes received: 72769128 05:48:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.talos.tests.zip 05:48:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:48:35 INFO - Fetch https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.talos.tests.zip into memory 05:48:36 INFO - Content-Length response header: 14495033 05:48:36 INFO - Bytes received: 14495033 05:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:36 INFO - trying https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:36 INFO - Downloading https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:48:37 INFO - Downloaded 61816108 bytes. 05:48:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:37 INFO - mkdir: /builds/slave/test/properties 05:48:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:37 INFO - Contents: 05:48:37 INFO - build_url:https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:37 INFO - Running post-action listener: _resource_record_post_action 05:48:37 INFO - Running post-action listener: set_extra_try_arguments 05:48:37 INFO - [mozharness: 2017-07-17 12:48:37.438192Z] Finished download-and-extract step (success) 05:48:37 INFO - [mozharness: 2017-07-17 12:48:37.438289Z] Running populate-webroot step. 05:48:37 INFO - Running pre-action listener: _resource_record_pre_action 05:48:37 INFO - Running main action method: populate_webroot 05:48:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:37 INFO - '--tppagecycles', 05:48:37 INFO - '7'], 05:48:37 INFO - 'tests': ['tsvgm']}}, 05:48:37 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['damp', 'tps']}, 05:48:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'tests': ['damp', 'tps']}, 05:48:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['dromaeo_dom']}, 05:48:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:48:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:48:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:48:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['a11yr', 05:48:37 INFO - 'ts_paint', 05:48:37 INFO - 'tpaint', 05:48:37 INFO - 'sessionrestore', 05:48:37 INFO - 'sessionrestore_no_auto_restore', 05:48:37 INFO - 'tabpaint']}, 05:48:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:37 INFO - 'ts_paint', 05:48:37 INFO - 'tpaint', 05:48:37 INFO - 'sessionrestore', 05:48:37 INFO - 'sessionrestore_many_windows', 05:48:37 INFO - 'sessionrestore_no_auto_restore', 05:48:37 INFO - 'tabpaint']}, 05:48:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:37 INFO - 'ts_paint', 05:48:37 INFO - 'tpaint', 05:48:37 INFO - 'sessionrestore', 05:48:37 INFO - 'sessionrestore_many_windows', 05:48:37 INFO - 'sessionrestore_no_auto_restore', 05:48:37 INFO - 'tabpaint']}, 05:48:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:37 INFO - 'ts_paint', 05:48:37 INFO - 'tpaint', 05:48:37 INFO - 'sessionrestore', 05:48:37 INFO - 'sessionrestore_many_windows', 05:48:37 INFO - 'sessionrestore_no_auto_restore', 05:48:37 INFO - 'tabpaint']}, 05:48:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['a11yr', 05:48:37 INFO - 'ts_paint', 05:48:37 INFO - 'tpaint', 05:48:37 INFO - 'sessionrestore', 05:48:37 INFO - 'sessionrestore_no_auto_restore', 05:48:37 INFO - 'tabpaint']}, 05:48:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['a11yr', 05:48:37 INFO - 'ts_paint', 05:48:37 INFO - 'tpaint', 05:48:37 INFO - 'sessionrestore', 05:48:37 INFO - 'sessionrestore_no_auto_restore', 05:48:37 INFO - 'tabpaint']}, 05:48:37 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 05:48:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:48:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:48:37 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:48:37 INFO - 'talos_options': ['--mitmproxy', 05:48:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:48:37 INFO - '--firstNonBlankPaint'], 05:48:37 INFO - 'tests': ['quantum_pageload_google', 05:48:37 INFO - 'quantum_pageload_youtube', 05:48:37 INFO - 'quantum_pageload_amazon', 05:48:37 INFO - 'quantum_pageload_facebook']}, 05:48:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['tsvgx', 05:48:37 INFO - 'tsvgr_opacity', 05:48:37 INFO - 'tart', 05:48:37 INFO - 'tscrollx', 05:48:37 INFO - 'cart', 05:48:37 INFO - 'tsvg_static']}, 05:48:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:37 INFO - 'tsvgr_opacity', 05:48:37 INFO - 'tart', 05:48:37 INFO - 'tscrollx', 05:48:37 INFO - 'cart', 05:48:37 INFO - 'tsvg_static']}, 05:48:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'talos_options': ['--disable-e10s'], 05:48:37 INFO - 'tests': ['tp5o']}, 05:48:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:48:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'talos_options': ['--disable-e10s', 05:48:37 INFO - '--xperf_path', 05:48:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:37 INFO - 'tests': ['tp5n']}, 05:48:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:48:37 INFO - 'talos_options': ['--xperf_path', 05:48:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:37 INFO - 'tests': ['tp5n']}}, 05:48:37 INFO - 'talos.zip': {'path': '', 05:48:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:37 INFO - Running post-action listener: _resource_record_post_action 05:48:37 INFO - [mozharness: 2017-07-17 12:48:37.453464Z] Finished populate-webroot step (success) 05:48:37 INFO - [mozharness: 2017-07-17 12:48:37.453554Z] Running create-virtualenv step. 05:48:37 INFO - Running pre-action listener: _resource_record_pre_action 05:48:37 INFO - Running main action method: create_virtualenv 05:48:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:48:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:48:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:37 INFO - Using real prefix '/usr' 05:48:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:40 INFO - Installing pip.................done. 05:48:40 INFO - Return code: 0 05:48:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:48:40 INFO - Reading from file tmpfile_stdout 05:48:40 INFO - Output received: 05:48:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:48:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:48:40 INFO - Using env: {'DISPLAY': ':0', 05:48:40 INFO - 'HOME': '/home/cltbld', 05:48:40 INFO - 'LANG': 'en_US.UTF-8', 05:48:40 INFO - 'LANGUAGE': 'en_US:en', 05:48:40 INFO - 'LOGNAME': 'cltbld', 05:48:40 INFO - 'MAIL': '/var/mail/cltbld', 05:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:40 INFO - 'MOZ_NO_REMOTE': '1', 05:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:40 INFO - 'NO_EM_RESTART': '1', 05:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:40 INFO - 'PWD': '/builds/slave/test', 05:48:40 INFO - 'SHELL': '/bin/bash', 05:48:40 INFO - 'SHLVL': '1', 05:48:40 INFO - 'TERM': 'linux', 05:48:40 INFO - 'TMOUT': '86400', 05:48:40 INFO - 'USER': 'cltbld', 05:48:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:40 INFO - '_': '/tools/buildbot/bin/python'} 05:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:48:40 INFO - Cleaning up... 05:48:40 INFO - Return code: 0 05:48:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:48:40 INFO - Using env: {'DISPLAY': ':0', 05:48:40 INFO - 'HOME': '/home/cltbld', 05:48:40 INFO - 'LANG': 'en_US.UTF-8', 05:48:40 INFO - 'LANGUAGE': 'en_US:en', 05:48:40 INFO - 'LOGNAME': 'cltbld', 05:48:40 INFO - 'MAIL': '/var/mail/cltbld', 05:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:40 INFO - 'MOZ_NO_REMOTE': '1', 05:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:40 INFO - 'NO_EM_RESTART': '1', 05:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:40 INFO - 'PWD': '/builds/slave/test', 05:48:40 INFO - 'SHELL': '/bin/bash', 05:48:40 INFO - 'SHLVL': '1', 05:48:40 INFO - 'TERM': 'linux', 05:48:40 INFO - 'TMOUT': '86400', 05:48:40 INFO - 'USER': 'cltbld', 05:48:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:40 INFO - '_': '/tools/buildbot/bin/python'} 05:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:40 INFO - Downloading/unpacking psutil>=3.1.1 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:41 INFO - Installing collected packages: psutil 05:48:41 INFO - Running setup.py install for psutil 05:48:41 INFO - building 'psutil._psutil_linux' extension 05:48:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:48:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:48:42 INFO - building 'psutil._psutil_posix' extension 05:48:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:48:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:48:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:42 INFO - Successfully installed psutil 05:48:42 INFO - Cleaning up... 05:48:42 INFO - Return code: 0 05:48:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:48:42 INFO - Using env: {'DISPLAY': ':0', 05:48:42 INFO - 'HOME': '/home/cltbld', 05:48:42 INFO - 'LANG': 'en_US.UTF-8', 05:48:42 INFO - 'LANGUAGE': 'en_US:en', 05:48:42 INFO - 'LOGNAME': 'cltbld', 05:48:42 INFO - 'MAIL': '/var/mail/cltbld', 05:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:42 INFO - 'MOZ_NO_REMOTE': '1', 05:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:42 INFO - 'NO_EM_RESTART': '1', 05:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:42 INFO - 'PWD': '/builds/slave/test', 05:48:42 INFO - 'SHELL': '/bin/bash', 05:48:42 INFO - 'SHLVL': '1', 05:48:42 INFO - 'TERM': 'linux', 05:48:42 INFO - 'TMOUT': '86400', 05:48:42 INFO - 'USER': 'cltbld', 05:48:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:42 INFO - '_': '/tools/buildbot/bin/python'} 05:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:43 INFO - Installing collected packages: mozsystemmonitor 05:48:43 INFO - Running setup.py install for mozsystemmonitor 05:48:43 INFO - Successfully installed mozsystemmonitor 05:48:43 INFO - Cleaning up... 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48: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 05:48: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 05:48: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 05:48: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 05:48:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:45 INFO - warning: no files found matching '*.txt' 05:48:45 INFO - no previously-included directories found matching 'build' 05:48:45 INFO - no previously-included directories found matching 'dist' 05:48:45 INFO - no previously-included directories found matching '.git*' 05:48:45 INFO - Installing collected packages: jsonschema, functools32 05:48:45 INFO - Running setup.py install for functools32 05:48:45 INFO - warning: no files found matching '*.txt' 05:48:45 INFO - no previously-included directories found matching 'build' 05:48:45 INFO - no previously-included directories found matching 'dist' 05:48:45 INFO - no previously-included directories found matching '.git*' 05:48:45 INFO - Successfully installed jsonschema functools32 05:48:45 INFO - Cleaning up... 05:48:45 INFO - Return code: 0 05:48:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48: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', '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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:48: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 functools32==3.2.3-2 05:48:45 INFO - Using env: {'DISPLAY': ':0', 05:48:45 INFO - 'HOME': '/home/cltbld', 05:48:45 INFO - 'LANG': 'en_US.UTF-8', 05:48:45 INFO - 'LANGUAGE': 'en_US:en', 05:48:45 INFO - 'LOGNAME': 'cltbld', 05:48:45 INFO - 'MAIL': '/var/mail/cltbld', 05:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:45 INFO - 'MOZ_NO_REMOTE': '1', 05:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:45 INFO - 'NO_EM_RESTART': '1', 05:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:45 INFO - 'PWD': '/builds/slave/test', 05:48:45 INFO - 'SHELL': '/bin/bash', 05:48:45 INFO - 'SHLVL': '1', 05:48:45 INFO - 'TERM': 'linux', 05:48:45 INFO - 'TMOUT': '86400', 05:48:45 INFO - 'USER': 'cltbld', 05:48:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:45 INFO - '_': '/tools/buildbot/bin/python'} 05:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:48:45 INFO - Cleaning up... 05:48:45 INFO - Return code: 0 05:48:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48: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', '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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:48: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 blobuploader==1.2.4 05:48:45 INFO - Using env: {'DISPLAY': ':0', 05:48:45 INFO - 'HOME': '/home/cltbld', 05:48:45 INFO - 'LANG': 'en_US.UTF-8', 05:48:45 INFO - 'LANGUAGE': 'en_US:en', 05:48:45 INFO - 'LOGNAME': 'cltbld', 05:48:45 INFO - 'MAIL': '/var/mail/cltbld', 05:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:45 INFO - 'MOZ_NO_REMOTE': '1', 05:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:45 INFO - 'NO_EM_RESTART': '1', 05:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:45 INFO - 'PWD': '/builds/slave/test', 05:48:45 INFO - 'SHELL': '/bin/bash', 05:48:45 INFO - 'SHLVL': '1', 05:48:45 INFO - 'TERM': 'linux', 05:48:45 INFO - 'TMOUT': '86400', 05:48:45 INFO - 'USER': 'cltbld', 05:48:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:45 INFO - '_': '/tools/buildbot/bin/python'} 05:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48:47 INFO - Downloading docopt-0.6.1.tar.gz 05:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:47 INFO - Running setup.py install for blobuploader 05:48:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:47 INFO - Running setup.py install for requests 05:48:48 INFO - Running setup.py install for docopt 05:48:48 INFO - Successfully installed blobuploader requests docopt 05:48:48 INFO - Cleaning up... 05:48:48 INFO - Return code: 0 05:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:48 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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:48 INFO - Using env: {'DISPLAY': ':0', 05:48:48 INFO - 'HOME': '/home/cltbld', 05:48:48 INFO - 'LANG': 'en_US.UTF-8', 05:48:48 INFO - 'LANGUAGE': 'en_US:en', 05:48:48 INFO - 'LOGNAME': 'cltbld', 05:48:48 INFO - 'MAIL': '/var/mail/cltbld', 05:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:48 INFO - 'MOZ_NO_REMOTE': '1', 05:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:48 INFO - 'NO_EM_RESTART': '1', 05:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:48 INFO - 'PWD': '/builds/slave/test', 05:48:48 INFO - 'SHELL': '/bin/bash', 05:48:48 INFO - 'SHLVL': '1', 05:48:48 INFO - 'TERM': 'linux', 05:48:48 INFO - 'TMOUT': '86400', 05:48:48 INFO - 'USER': 'cltbld', 05:48:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:48 INFO - '_': '/tools/buildbot/bin/python'} 05:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:48 INFO - Running setup.py (path:/tmp/pip-cB1SAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:48 INFO - Running setup.py (path:/tmp/pip-TLvWYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:48 INFO - Running setup.py (path:/tmp/pip-1mVg4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:48 INFO - Running setup.py (path:/tmp/pip-XNkgPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:48 INFO - Running setup.py (path:/tmp/pip-z8Gjle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:48 INFO - Running setup.py (path:/tmp/pip-z08SV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:49 INFO - Running setup.py (path:/tmp/pip-wnPY6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:49 INFO - Running setup.py (path:/tmp/pip-hjRVOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:49 INFO - Running setup.py (path:/tmp/pip-YwUiWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:49 INFO - Running setup.py (path:/tmp/pip-PEx93D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:49 INFO - Running setup.py (path:/tmp/pip-hQqiEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:49 INFO - Running setup.py (path:/tmp/pip-vDTIUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:49 INFO - Running setup.py (path:/tmp/pip-sZvL79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:49 INFO - Running setup.py (path:/tmp/pip-ZJf4Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:49 INFO - Running setup.py (path:/tmp/pip-m53UbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:49 INFO - Running setup.py (path:/tmp/pip-yziYzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:49 INFO - Running setup.py (path:/tmp/pip-irTu3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:49 INFO - Running setup.py install for manifestparser 05:48:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozcrash 05:48:49 INFO - Running setup.py install for mozdebug 05:48:50 INFO - Running setup.py install for mozdevice 05:48:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozfile 05:48:50 INFO - Running setup.py install for mozhttpd 05:48:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozinfo 05:48:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozInstall 05:48:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozleak 05:48:50 INFO - Running setup.py install for mozlog 05:48:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for moznetwork 05:48:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozprocess 05:48:51 INFO - Running setup.py install for mozprofile 05:48:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:51 INFO - Running setup.py install for mozrunner 05:48:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:51 INFO - Running setup.py install for mozscreenshot 05:48:51 INFO - Running setup.py install for moztest 05:48:51 INFO - Running setup.py install for mozversion 05:48:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:51 INFO - Cleaning up... 05:48:51 INFO - Return code: 0 05:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:51 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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:48:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:51 INFO - Using env: {'DISPLAY': ':0', 05:48:51 INFO - 'HOME': '/home/cltbld', 05:48:51 INFO - 'LANG': 'en_US.UTF-8', 05:48:51 INFO - 'LANGUAGE': 'en_US:en', 05:48:51 INFO - 'LOGNAME': 'cltbld', 05:48:51 INFO - 'MAIL': '/var/mail/cltbld', 05:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:51 INFO - 'MOZ_NO_REMOTE': '1', 05:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:51 INFO - 'NO_EM_RESTART': '1', 05:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:51 INFO - 'PWD': '/builds/slave/test', 05:48:51 INFO - 'SHELL': '/bin/bash', 05:48:51 INFO - 'SHLVL': '1', 05:48:51 INFO - 'TERM': 'linux', 05:48:51 INFO - 'TMOUT': '86400', 05:48:51 INFO - 'USER': 'cltbld', 05:48:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:51 INFO - '_': '/tools/buildbot/bin/python'} 05:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:51 INFO - Running setup.py (path:/tmp/pip-qIB1bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:51 INFO - Running setup.py (path:/tmp/pip-TLR3Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:51 INFO - Running setup.py (path:/tmp/pip-yyZFat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:51 INFO - Running setup.py (path:/tmp/pip-fXGQ4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:52 INFO - Running setup.py (path:/tmp/pip-x7p2nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:52 INFO - Running setup.py (path:/tmp/pip-T8T84r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:52 INFO - Running setup.py (path:/tmp/pip-N7KPj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:52 INFO - Running setup.py (path:/tmp/pip-J4tMrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:52 INFO - Running setup.py (path:/tmp/pip-slLGRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:52 INFO - Running setup.py (path:/tmp/pip-ceSwwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:52 INFO - Running setup.py (path:/tmp/pip-g6yLYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:52 INFO - Running setup.py (path:/tmp/pip-JHQFtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:52 INFO - Running setup.py (path:/tmp/pip-dJQFv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:52 INFO - Running setup.py (path:/tmp/pip-bQwOwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:52 INFO - Running setup.py (path:/tmp/pip-v2fKwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:52 INFO - Running setup.py (path:/tmp/pip-EZ_8vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:52 INFO - Running setup.py (path:/tmp/pip-LAYwGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:48:52 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:48:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48: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 05:48: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 05:48: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 05:48: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 05:48:54 INFO - Downloading blessings-1.6.tar.gz 05:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:54 INFO - Installing collected packages: blessings 05:48:54 INFO - Running setup.py install for blessings 05:48:54 INFO - Successfully installed blessings 05:48:54 INFO - Cleaning up... 05:48:54 INFO - Return code: 0 05:48:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:54 INFO - Reading from file tmpfile_stdout 05:48:54 INFO - Current package versions: 05:48:54 INFO - argparse == 1.2.1 05:48:54 INFO - blessings == 1.6 05:48:54 INFO - blobuploader == 1.2.4 05:48:54 INFO - docopt == 0.6.1 05:48:54 INFO - functools32 == 3.2.3-2 05:48:54 INFO - jsonschema == 2.5.1 05:48:54 INFO - manifestparser == 1.1 05:48:54 INFO - mozInstall == 1.13 05:48:54 INFO - mozcrash == 1.0 05:48:54 INFO - mozdebug == 0.1 05:48:54 INFO - mozdevice == 0.51 05:48:54 INFO - mozfile == 1.2 05:48:54 INFO - mozhttpd == 0.7 05:48:54 INFO - mozinfo == 0.10 05:48:54 INFO - mozleak == 0.1 05:48:54 INFO - mozlog == 3.5 05:48:54 INFO - moznetwork == 0.27 05:48:54 INFO - mozprocess == 0.25 05:48:54 INFO - mozprofile == 0.28 05:48:54 INFO - mozrunner == 6.13 05:48:54 INFO - mozscreenshot == 0.1 05:48:54 INFO - mozsystemmonitor == 0.3 05:48:54 INFO - moztest == 0.8 05:48:54 INFO - mozversion == 1.4 05:48:54 INFO - psutil == 3.1.1 05:48:54 INFO - requests == 1.2.3 05:48:54 INFO - wsgiref == 0.1.2 05:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:54 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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:48:54 INFO - Using env: {'DISPLAY': ':0', 05:48:54 INFO - 'HOME': '/home/cltbld', 05:48:54 INFO - 'LANG': 'en_US.UTF-8', 05:48:54 INFO - 'LANGUAGE': 'en_US:en', 05:48:54 INFO - 'LOGNAME': 'cltbld', 05:48:54 INFO - 'MAIL': '/var/mail/cltbld', 05:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:54 INFO - 'MOZ_NO_REMOTE': '1', 05:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:54 INFO - 'NO_EM_RESTART': '1', 05:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:54 INFO - 'PWD': '/builds/slave/test', 05:48:54 INFO - 'SHELL': '/bin/bash', 05:48:54 INFO - 'SHLVL': '1', 05:48:54 INFO - 'TERM': 'linux', 05:48:54 INFO - 'TMOUT': '86400', 05:48:54 INFO - 'USER': 'cltbld', 05:48:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:54 INFO - '_': '/tools/buildbot/bin/python'} 05:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:48:54 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:48:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:48:56 INFO - Installing collected packages: marionette-driver, simplejson 05:48:56 INFO - Running setup.py install for marionette-driver 05:48:56 INFO - Running setup.py install for simplejson 05:48:56 INFO - building 'simplejson._speedups' extension 05:48:56 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 05:48:57 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 05:48:57 INFO - Successfully installed marionette-driver simplejson 05:48:57 INFO - Cleaning up... 05:48:57 INFO - Return code: 0 05:48:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:57 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 0x15e81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1959b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, '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': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:48:57 INFO - Using env: {'DISPLAY': ':0', 05:48:57 INFO - 'HOME': '/home/cltbld', 05:48:57 INFO - 'LANG': 'en_US.UTF-8', 05:48:57 INFO - 'LANGUAGE': 'en_US:en', 05:48:57 INFO - 'LOGNAME': 'cltbld', 05:48:57 INFO - 'MAIL': '/var/mail/cltbld', 05:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:57 INFO - 'MOZ_NO_REMOTE': '1', 05:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:57 INFO - 'NO_EM_RESTART': '1', 05:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:57 INFO - 'PWD': '/builds/slave/test', 05:48:57 INFO - 'SHELL': '/bin/bash', 05:48:57 INFO - 'SHLVL': '1', 05:48:57 INFO - 'TERM': 'linux', 05:48:57 INFO - 'TMOUT': '86400', 05:48:57 INFO - 'USER': 'cltbld', 05:48:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:57 INFO - '_': '/tools/buildbot/bin/python'} 05:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:57 INFO - Cleaning up... 05:48:57 INFO - Return code: 0 05:48:57 INFO - Running post-action listener: _resource_record_post_action 05:48:57 INFO - Running post-action listener: _start_resource_monitoring 05:48:57 INFO - Starting resource monitoring. 05:48:57 INFO - [mozharness: 2017-07-17 12:48:57.571608Z] Finished create-virtualenv step (success) 05:48:57 INFO - [mozharness: 2017-07-17 12:48:57.572225Z] Running install step. 05:48:57 INFO - Running pre-action listener: _resource_record_pre_action 05:48:57 INFO - Running main action method: install 05:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:57 INFO - Reading from file tmpfile_stdout 05:48:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:57 INFO - Reading from file tmpfile_stdout 05:48:57 INFO - Output received: 05:48:57 INFO - Usage: mozinstall [options] installer 05:48:57 INFO - Options: 05:48:57 INFO - -h, --help show this help message and exit 05:48:57 INFO - -d DEST, --destination=DEST 05:48:57 INFO - Directory to install application into. [default: 05:48:57 INFO - "/builds/slave/test"] 05:48:57 INFO - --app=APP Application being installed. [default: firefox] 05:48:57 INFO - mkdir: /builds/slave/test/build/application 05:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:49:15 INFO - Reading from file tmpfile_stdout 05:49:15 INFO - Output received: 05:49:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:15 INFO - Running post-action listener: _resource_record_post_action 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.956556Z] Finished install step (success) 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.956811Z] Running setup-mitmproxy step. 05:49:15 INFO - Running pre-action listener: _resource_record_pre_action 05:49:15 INFO - Running main action method: setup_mitmproxy 05:49:15 INFO - Skipping: mitmproxy is not required 05:49:15 INFO - Running post-action listener: _resource_record_post_action 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.957957Z] Finished setup-mitmproxy step (success) 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.958178Z] Running run-tests step. 05:49:15 INFO - Running pre-action listener: _resource_record_pre_action 05:49:15 INFO - Running pre-action listener: _set_gcov_prefix 05:49:15 INFO - Running main action method: run_tests 05:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:15 INFO - Python 2.7.3 05:49:15 INFO - Return code: 0 05:49:15 INFO - grabbing minidump binary from tooltool 05:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:15 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 0x1956d00>, '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 0x1957c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1958090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:49:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:49:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:49:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:16 INFO - Return code: 0 05:49:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:16 INFO - ENV: RUST_BACKTRACE is now 1 05:49:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:16 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/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:49:16 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/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:49:16 INFO - Using env: {'DISPLAY': ':0', 05:49:16 INFO - 'HOME': '/home/cltbld', 05:49:16 INFO - 'LANG': 'en_US.UTF-8', 05:49:16 INFO - 'LANGUAGE': 'en_US:en', 05:49:16 INFO - 'LOGNAME': 'cltbld', 05:49:16 INFO - 'MAIL': '/var/mail/cltbld', 05:49:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:16 INFO - 'MOZ_NO_REMOTE': '1', 05:49:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:16 INFO - 'NO_EM_RESTART': '1', 05:49:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:16 INFO - 'PWD': '/builds/slave/test', 05:49:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:16 INFO - 'RUST_BACKTRACE': '1', 05:49:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:49:16 INFO - 'SHELL': '/bin/bash', 05:49:16 INFO - 'SHLVL': '1', 05:49:16 INFO - 'TERM': 'linux', 05:49:16 INFO - 'TMOUT': '86400', 05:49:16 INFO - 'USER': 'cltbld', 05:49:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1500288307.299593-304713271', 05:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:16 INFO - '_': '/tools/buildbot/bin/python'} 05:49:16 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/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:49:16 INFO - mozversion application_buildid: 20170717120626 05:49:16 INFO - mozversion application_changeset: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e 05:49:16 INFO - mozversion application_display_name: Nightly 05:49:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:16 INFO - mozversion application_name: Firefox 05:49:16 INFO - mozversion application_remotingname: firefox 05:49:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:16 INFO - mozversion application_vendor: Mozilla 05:49:16 INFO - mozversion application_version: 56.0a1 05:49:16 INFO - mozversion platform_buildid: 20170717120626 05:49:16 INFO - mozversion platform_changeset: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e 05:49:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:16 INFO - mozversion platform_version: 56.0a1 05:49:16 INFO - using testdate: 1500295756 05:49:16 INFO - actual date: 1500295756 05:49:16 INFO - starting webserver on 'localhost:58569' 05:49:16 INFO - SUITE-START | Running 2 tests 05:49:16 INFO - TEST-START | dromaeo_css 05:49:16 INFO - Initialising browser for dromaeo_css test... 05:49:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html -profile /tmp/tmpjBXnLi/profile 05:49:16 INFO - TEST-INFO | started process 15140 (/builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html) 05:49:22 INFO - TEST-INFO | 15140: exit 0 05:49:22 INFO - Browser initialized. 05:49:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:22 INFO - TEST-INFO | started process 15367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjBXnLi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:34 INFO - PID 15367 | RSS: Main: 169070592 05:49:34 INFO - PID 15367 | 05:52:32 INFO - PID 15367 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58569/tests/dromaeo/cssquery-ext.html) 05:52:34 INFO - PID 15367 | RSS: Main: 176734208 05:52:34 INFO - PID 15367 | 05:55:35 INFO - PID 15367 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-ext.html (next: http://localhost:58569/tests/dromaeo/cssquery-jquery.html) 05:55:36 INFO - PID 15367 | RSS: Main: 175161344 05:55:36 INFO - PID 15367 | 05:58:38 INFO - PID 15367 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58569/tests/dromaeo/cssquery-mootools.html) 05:58:38 INFO - PID 15367 | RSS: Main: 177426432 05:58:38 INFO - PID 15367 | 06:01:40 INFO - PID 15367 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58569/tests/dromaeo/cssquery-prototype.html) 06:01:40 INFO - PID 15367 | RSS: Main: 176242688 06:01:40 INFO - PID 15367 | 06:04:44 INFO - PID 15367 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58569/tests/dromaeo/cssquery-yui.html) 06:04:44 INFO - PID 15367 | RSS: Main: 175861760 06:04:44 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | Cycle 1(1): loaded http://localhost:58569/tests/dromaeo/cssquery-yui.html (next: http://localhost:58569/tests/dromaeo/cssquery-dojo.html) 06:07:46 INFO - PID 15367 | RSS: Main: 179204096 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | __start_tp_report 06:07:46 INFO - PID 15367 | _x_x_mozilla_page_load 06:07:46 INFO - PID 15367 | _x_x_mozilla_page_load_details 06:07:46 INFO - PID 15367 | |i|pagename|runs| 06:07:46 INFO - PID 15367 | |0;dojo.html;3068;3112.953305700414;3143;3149.527570864371;3155.069254569903;5888;5897.941020589793;5910.438508341701;5926;5968.1644569760265;5960.5529585281065;5975.850603734909;5977.850553736148;5983.311919129302;6006.489448396892;5456.208849716789;5473.31583552056;5497.147942068966;5497.312835895503;5512.33851937766;5428.647137936041;5483.150111732668;5486.423925487826;5487.725613719298;5489.835304940858;5464.9453505465035;5488.862778430531;5491.835244942658;5497.505224529791;5507.862303442406;5491.368492623359;5494.780208791643;5507.614466987313;5520.585956053312;5541.085720856054;5432.511074003319;5477.260569823103;5495.752691128869;5527.917081243784;5593.216949627055;5951.107333899907;6017.849553761147;6055.303640081359;6069.908951365733;6094.268687757498;6395.456386207178;6411.070394792776;6474.935250647527;6485.156929599169;6509.1863517060365;6349.396807303298;6415.358464153594;6436.645984470852;6439.323870993572;6446.065320528544;5952.761889524414;5953.702314884238;5971.641701497924;5980.162777211194;5995.640261584319;5685.449957947871;6475.708593113368;6525.902111468332;6585.440237579859;6667.766628167991;6297.779577714758;6303.905441418382;6311.495080393557;6389.329120442287;6390;6306.810795676045;6375.71309291083;6421.165248517663;6482.57863238888;6502;6281.057841323838;6307.053941908659;6344.841378965562;6390.584612000205;6445.1621289233035;6024.698765061729;6394.584352017104;6404.967975160188;6530;6548.27968923418;5245.842624721265;5247.501487358695;5309.203619457112;5341.172118321666;5348.251244825728;4375.124975005012;4473.4408198975125;4477.395551600493;4478.328250762412;4488.820447182142;5508.531774799187;5512.944870551323;5520.944790552124;5522.834314970557;5524.392316845144;6441.227052753699;6444.033394990789;6444.130042444303;6449.580777249464;6452.935470645233;5411.729413529387;5467.507924286833;5495.065838807413;5510.0632892408385;5535.474129957647;5670.631408958405;5707.857303567444;5756.3380211276235;5806.44838740319;5813.680247586423;6112.388761123852;6208.161898143783;6241.7191226394925;6336.112944187817;6341.968290158519;6466.450351719968;6516.087747715229;6558.1802274715665;6568.6058836469965;6571.605703657796;6316.557840951273;6365.045243213555;6369.7452101915405;6392.296847346881;6392.648404337806;6380.489560835029;6389.393007664265;6426.260979987174;6444.484441244783;6479.222493300834;6496;6521;6608.801735947929;6613.2394774601535;6626.83432914181;6115.663638499926;6243.562950593415;6293.716782744696;6370.044493326038;6382.680865956777;6183;6208.565400422108;6221.720022599085;6225.097360882556;6225.190725205694;6095.664738439428;6142.170806941006;6149.692515374124;6150.600210986271;6150.723217455135;5262.710550919736;6280.057991301342;6280.434760871543;6301.936980630318;6400.583962042452;6097.5731698780655;6102.420270074336;6193.504519638508;6196.938030619636;6199.845003874939 06:07:46 INFO - PID 15367 | |1;ext.html;786.6224212378058;846.7586737779734;860.0582362313266;893.2630579771686;895.180909467837;41641.79179104104;43097.35353969685;43155.568444315584;43156.136877262434;43206;38819.41770873439;38892.02769930753;38908.80545597275;38974.8051259744;39000.21999560007;6802.285759995191;6931.2375638679705;6933.583984960893;6962.1297337832775;6965.129358830146;6935.271796461375;6989.266127056637;7000.754973575926;7032.191298000745;7038.5424947378515;6940.652967351637;6945.270746571613;6981.4763892708;6981.5461994970165;6987.650617469131;6918.515703900729;6951;6979.336962988534;6984.301569843001;7002.47481438889;6352.650604216767;6353.174087368659;6411.67941602918;6419.390157934989;6435.8391040223905;34336.82831585851;34386.31227375464;34407.31185376278;34566.654333456594;34641;3340.9832950835334;3395.6774106459848;3405.8126803025825;3414.6243913169533;3414.778039427454;27296;30548.236294092603;31156.53265201024;31476;31593.684063159533;4788.95211047892;4817.638677099231;4883.4628190898975;4884.3650325457465;4978.5270399312;182918;184124;185616.99999999866;186062;186261;50190;50402.24396634053;50555;50557;50839.74580127076;53946.730266348415;54159.458405416226;54582.18126728102;54643.72678136584;54704.45295546993;14150.150990940576;14253.78619320711;14358.712825743636;14377.20925349095;14419.639509012359;11441.141914356456;11537.711557211136;11556.88443115575;11573.363465009337;11626.476808543466;14693.55919322422;14851;14982;14990.400383984519;15023.948323617242;5665.49010589049;5708.543316534668;5794.797182098607;5809.7966571170655;5832.387599302012;994.179801663616;998.8601595776597;1013.4020927652573;1024.7386916336436;1032.5972870580329;22525.54948901013;22558.436039099153;22929.426764331027;23039.88480057589;23286.417839553807;1100.9504572294265;1101.6254473479055;1108.711734948919;1113.9164562657834;1115.827046807746;11907.464164112636;11934.428154214105;12037.699057523458;12235.938820306019;12463.439145238304;221242;222036;222741;223447;224598;52677.473225267255;52685.7365713169;52747.736261319216;52754.73622631862;52809.2078618821;1408.64783804049;1457.6210185351672;1469.9632509187356;1470.7573250413561;1477.697072100217;22055.779442206014;22084.558308834054;22099;22236.444088897908;22296.77703222947;36945.81527092347;37124.443133352484;37202.8139859299;37231.25537489289;37299.440508391854;192951;193350;193615;193887;193973;31812.681873180973;34944.30111397707;35682.28635427225;35688.82155589309;35845.028523431465;44047.11905761931;44233.55766442423;44276.11447771091;45002.64992050244;45419;29637.407251855275;31171.688283116877;31875;32283.51574726428;32446.513302300955;30702.84648576743;30997.53503697401;31482;32094;32303.35393292074;34233.31533369368;34271.31457370789;34403.82798085993;34561.827190863885;34611.13472163216;30381;30517.847410762803;30755.69244307618;31054.68945310518;31076.22309442282;22142.335729928127;22950.655740164246;23049.423764406023;23213.41966450852;23393.649095263925 06:07:46 INFO - PID 15367 | |2;jquery.html;564.8305508347495;567.5034344948173;568.7525926222094;585.29179692572;600.2526854066687;21140.2600908968;22036.89815509226;22189.778102218974;22211.44471388216;22233.333000010007;24378.26865194047;25491.10781122661;25792.226233212987;26934.326641833963;27216.863915680442;6421.325760795119;6610.669466526654;6626.635535045571;6649.60102393858;6659.733610655592;6569.178852643419;6635.469162466991;6638.302978187269;6641.037049627801;6645.767398141066;4024.899377515571;4771.785269662873;5939.55453340999;6479.805605831809;6581.506387020969;6527.706253218616;6557.278699343068;6588.769393071243;6597.9340206598035;6608.2730899601;6123.755049798003;6135.815925522242;6141.324454310023;6165.691715414257;6173.660448675321;27522.449551009067;29021;29453.263668408246;29489;29514.262143446373;1952.5509132899372;1985.2753744883157;2001.0595020340418;2004.1582535335194;2009.2264478175862;18562.53593660156;19155.52111197217;19158.904205479022;19172.71240931387;19182.232710691555;2327.767223277676;2361.244401791427;2416.9516609667708;2420.770026847447;2430.1008626808016;133339;134797;136566;138059;138111.30944345213;14243.64390890236;14656.193909335088;14739.410423583151;14986.925065374604;15017.849821501864;23279.18522851692;23404.18085367004;23543.175988840307;23547.293581192593;23574.410639734146;9661.3614953642;9698.272629552812;9802.313838031412;9836.931602974213;9886.209103271722;8840.469571825712;8902.483519010084;8926.821463570823;9005.504697241584;9100.908990910139;8871.201591856634;9110.088991100969;9233;9431.717048488556;9548.331616786898;2706.4045909900183;2781.8887244510397;2786.8327900326044;2799.468101060792;2932.4574953633646;948.4309414351472;962.6005207838808;971.8007808399261;997.5361456922566;1000.8298589239847;19516.21935122579;19568;19585.223590408354;20104.195832166843;20194.091265892777;1004.924630652704;1020.642775028734;1048.764028093688;1052.5737076484036;1057.9153667706564;10689.198310126772;10709.892901070889;10829.133669306437;10907.018368346888;11295.830562541569;482205;494750;504430;505114;510427;98391.50804245933;100546.4972675132;102161.48919255356;102231.4888425568;103043.4847825756;1185.9229150105216;1204.1209916760638;1222.8104643780227;1224.240970598217;1234.6357824441811;16827.158642068094;17866.374676886247;17872.106394680475;18331.908340458747;18373.448796536126;51120;52693.47306527039;52826;53032.73483632557;53357.46642533525;62699.37300626935;62918.68540657451;63029.36970630235;63049;63425.68287158535;14923.477678281208;14988.325525351167;14990.47533336328;15077.472288469851;15104.697906042038;22413;22855.542889142456;22922.54154916859;22978.195763148877;23268.53462930698;18057.54856128555;18106.637867242844;19138.23447062102;19152.90423547929;19412.417627471197;17092.626398920333;17310.5672358187;17645;18161.09194540241;18486.81513184851;19717.507062323555;19859.30492432758;20085.79914200898;20091.296804611768;20101.49746256355;14745.631359216106;14767.630809229855;15206.239688015776;15207.315670795062;15237.238138093273;18755.34356297523;19337;19363.51591210231;19379.612407752047;19431.5426343022 06:07:46 INFO - PID 15367 | |3;mootools.html;1359.734851703918;1410.992945035275;1417.0505761140034;1419.701862608852;1421.2538417330893;12888.291143987077;13670.453181872737;13679.726405471885;13740.58778236652;13767.58697239082;13072.411741471633;13535.796963045563;13559.72880542391;13570.728585428285;13571.253581053063;2548.808839337057;2553.757393047667;2565.6536367590415;2578.123438031069;2586.8059895507818;2485.515324511721;2538.4288535079645;2564.3204550794053;2572.4083460804027;2576.3559110222445;2500.6374075759004;2520.7101183363966;2535.1760677779703;2549.413634863973;2568.4863027394595;2411.4694767151286;2425.1754403502805;2428.3807629054477;2429.7327293997646;2440.890159942807;2340.566995105911;2392.234484964812;2398.832081754278;2415;2415.384077060356;12905.741885162339;13179.86820131796;13223.140495867738;13242.139260948104;13258.933705331508;7077.929220707779;7318.487705860592;7338;7345.375643070345;7348.191698913115;4951.752412379403;4972.328735620681;5069.923951140736;5156.716380599066;5170.9741451292875;1866.6266746650588;1872.5599484121221;1878.042198478772;1926.412444204517;1933.0721253798256;20449.977501124886;20623.793762062338;20643.17427302906;20712.58574828495;21226.25708100209;5649.378568357477;6263.154474146023;6507.446867016357;6541.705623246965;6545.4436372907885;15060.472883449245;15082.321295541728;15117.16855572954;15156.621084472976;15171.620709482351;6995.580265184105;7234.5659260444545;7237.565746055148;7258.854822903512;7272.127344718668;6842.04211410403;6900.861982760317;6931.272216417305;6954.4436445084275;6987.755428560077;4923.507649235048;5047.268146118792;5117.8720531986255;5126.5898728101665;5132.0762262792305;1425.6720954180596;1454.4909281751513;1463.9707205855823;1464.985350146506;1483.8441963593882;862.4307956748515;868.1015149320549;868.8001759595202;899.7255836969656;904.8552231642906;6894.896576551356;7067.964660176666;7090.787276381717;7105.43156547475;7144;692.3906961873519;712.4870093532649;717.4224749077043;718.9496735228588;727.8580676768086;4502.932456013163;4799.400074990626;4958.851234462972;4999.950000500021;5126.666766660155;17072.914635426743;17455.30178792834;17616.119194040246;17619.207135678924;17636.823631763516;17079.573010674834;17211.655766884593;17400.129993500275;17406.738898916527;17593.208305626278;9165.266778657691;9567;10190.694279171637;10245.897541024644;10267;8035.758927232192;8179.304759095544;8212.548309843016;8308.6676532938;8314.251717345225;14991;15733.292001860173;15771.684566308839;15988.360465581713;16341.101239431946;15495.767563486332;15896.04623722534;16174.595635108746;16328.918355408146;16379.508614741577;11113.833292500458;11244.55021799119;11393.202475826612;11432.485538150637;11539.423028848356;12745.681357966125;12935.159214651394;12977.286249256003;12994.48022079144;13034.283114428797;9818.263630227904;10258.076773090457;10374.948125259325;10691;10694.518746656575;9888.473278315496;9973.501324933579;9977.600895964371;10029.04724051214;10104.444255566015;9344.15902568772;9414.058594140532;9450.621975120917;9501.239900807781;9516.762080948032;6917.9308206917285;7081.327273908971;7231.963840180976;7259.891101633585;7265.782026539212;6764.255931847394;7183.5330703504105;7193;7204.459665525002;7268.382187513909 06:07:46 INFO - PID 15367 | |4;prototype.html;491;507.60914096145956;520.4405264340834;528.3554064041867;531.3570579598688;6008.849778755528;6012.939870601293;6140.26316841979;6147.616786223098;6166.722497487613;5853.531717462603;5901.586888917777;5970.462658360747;5994.730237139328;6059.272887253535;4817.940053188293;4818.445878723939;4885.780139893695;4896.167651499253;4931.704097754128;4858.587020103296;4883.804647814083;4886.267059941002;4897;4918.114739346916;4856.465788763251;4884.925316430397;4886.706797592155;4904.092742842586;4906.9263961040615;4657.86026419208;4802.687825291362;4810.903781924342;4878.902421951541;4890.217565189588;4339.60943515082;4394.956050439487;4400.669949753781;4404.295312749945;4404.4494438195225;5934.940650593482;5949.226600541945;5965.194698715662;5990.97004514979;5999.650078732294;5517.917231241535;5534.889302213933;5564.4991950724625;5603.635763675389;5604.971975140098;6380.298167201604;6399.168108145911;6469.385408386196;6474.223093228796;6489.610623362566;4805.663603547753;4819.795051237191;4832.806687732486;4839.564439200489;4871.8782030449165;6704.363085506869;6723.428508576826;6782.762603308861;6785.2196997345445;6810.114685090906;4973.502649734997;4978.452370239271;4981.800727970913;4995.975020124876;5000.9498005418545;5017;5024.799008039638;5050.267711181858;5054.241863720471;5075.187969924795;5591.384947655754;5593.8321850344555;5594.580406469531;5620;5643.435656434323;6441.838954026093;6456.418922297016;6480.837979050561;6504.317046710122;6540.9345906541275;1740.8346207110305;1751.3099858636222;1756.604763928106;1775.2100315359542;1778.404234581404;1135.9204855660025;1214.1197631716934;1226.3316492511603;1239.4856134704178;1240.7084335181225;5423.538999185113;5443.510084092451;5558.360788509292;5608.298962629671;5618.69097199658;6560.901586476207;6595.406413422815;6648.83377915556;6663.13379260693;6701.39687428124;5587.580931430159;5610.72765529961;5650.5479561634975;5670.262865827416;5685.1756495307945;3437.7765445245977;3505.158761897126;3530.4051522131213;3559.7864128151878;3580.1944562473236;6470.870582588416;6490.545661803629;6504.252011018793;6516.446102081281;6552.180977377828;6848.459096703202;6853;6855.5886646801355;6857.142857142857;6896.793096207121;6388.79586542642;6399.048290271418;6435.871282574322;6475.805725828232;6503.902441463382;6566.868662626816;6593.307702691149;6610.2398224204835;6645.269020407654;6664.600123992576;6409.262934762562;6428.710708018057;6488.70800813974;6513.804585862432;6529.869402611826;6343.207099112611;6370.426661600478;6412.645441056583;6436.549441539048;6452.967525195946;4870.951290487192;4915.26271059344;4925.655204135819;4925.773618280033;4941.68906832416;6607.161587756649;6632.767853125118;6679.332066793282;6692.59844409337;6730.394264516217;6358.968205158944;6389.827458664076;6428.453581445442;6449.290578036506;6487.481001519773;6407.583507072025;6424.229092508929;6427.132337134614;6430.228372595318;6481.675916204265;6226.533010024175;6288.993760998218;6297.4647154992335;6369.14016607752;6415.422611964946;5913.58604897653;6298.401651843067;6345.90481142774;6455.771469687363;6497.902531462127;6205.47253483459;6212.63322069144;6226.533010024357;6290.2766181889665;6342.460890824332 06:07:46 INFO - PID 15367 | |5;yui.html;908.8318661047707;910.1262787723789;914.9130832570903;924.0251534630962;930.3069213435991;18038.368657096988;18771.812281877177;18777.967211803363;18895.716564251547;18905.62188756224;20113.798862011376;21461.248856290033;21537.67693484599;21686.783132168675;21833.890830545824;1001.7445551384405;1023.9692809215735;1026.4764969865385;1030.510507508931;1034.270839058462;767.6200280860982;1024.795040991801;1027.4913917610793;1031.736907088695;1033.2508931024984;831.5717405536154;1074.8710154781397;1096.3915027159962;1101.8347247912798;1112.9777404451906;1088.472091035851;1089.4008295437557;1089.8310761831929;1090.236834216044;1094.5129417409255;790.8734602463578;793.1949071692237;794.1145622630725;794.9983021393028;795.1372760554805;17947.282108715637;17976.280948762032;19901.800981990138;20218.79781202184;20249.39251822433;18608.90695546527;18805.529861753566;19062.904685476486;19233.326833560757;19498.220071197135;15709.214539273105;16023.679526409524;16237.594060148473;16273.674526509521;16287;3528.770629909048;3534.4874993125854;3547.7161827053774;3550.1124718820297;3553.076200187944;117908.87318943796;118880;122748.38625806815;125551;126254.73745262521;14838.703225935637;15068.397264109313;15085.94398392102;15089.698206035819;15280.388784448498;25961.740382595934;27767.722322776917;27867.442651146863;28004;28063.719362806518;7537.2462753724185;7676.078870535572;7734.651940662571;7792.883106753403;7850.057993040871;3926.2343842950922;3965.8017099144927;3986.740861843971;4013.418054382098;4024.0342317843506;5000.299958005882;5034.949650503521;5117.8464646060675;5153.5361817436615;5177.456367081402;892.4199270474114;921.5069937583361;923.6443969071821;926.8100039491889;929.1126973740062;670.5004771445305;674.3829396102511;677.7831094049857;691.2948792231896;717.2397258905472;11099.556017759362;11353.659390218307;11445.828312575319;11459.656210313704;11581.594644187413;626.9780557680459;626.9811905642838;650.1028580558799;652.3085529338916;661.5832025823701;4921.704697718148;5126.948730512647;5196.610254230948;5202.193659982709;5231.764570594332;98768.50615746876;102761;104285.47857260665;105303;106184;91471.54264228769;91652;93345;94299;96151.0384896156;80055.19944800477;80634.19365806384;82858.15592211371;83724.58137709272;84237;10106.49467526606;10131.696049118538;10195.898041019494;10355.068043876086;11010.779784404107;35609.08300086937;36804.26391472102;37356.06609834776;37484.81257593694;38978.6102138975;64046.35953640404;65774.34225657683;66987;67542.66228668825;71198.64400677964;18459;18469.53826154357;18613.348532801287;18771.34300299483;18926.3375781847;19442.542217300805;19652.803471965097;20487.4878128048;20674.896625517376;21161.6825747617;17330.74003889968;17722.5569360767;17814;18038.729419058986;18104.547386315448;18791.90604046971;19020.809791901906;19253.90373048126;19274.8072519273;19593.902030489757;17105.914470427568;17713.645727085644;17732.0247386395;18033.639327213645;18069.548261293574;11912.880871191177;12409;12518.248905065726;12534.498620055096;12573.93713031429;12428.502859885502;12741.17182383142;13110.803337949748;13616.523421680193;14216.786748198992 06:07:46 INFO - PID 15367 | __end_tp_report 06:07:46 INFO - PID 15367 | __start_cc_report 06:07:46 INFO - PID 15367 | _x_x_mozilla_cycle_collect,349 06:07:46 INFO - PID 15367 | __end_cc_report 06:07:46 INFO - PID 15367 | __startTimestamp1500296866698__endTimestamp 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | ------- Summary: start ------- 06:07:46 INFO - PID 15367 | Number of tests: 6 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | [#0] dojo.html Cycles:165 Average:5916.75 Median:6115.66 stddev:689.97 (11.3%) stddev-sans-first:654.89 06:07:46 INFO - PID 15367 | Values: 3068.0 3113.0 3143.0 3149.5 3155.1 5888.0 5897.9 5910.4 5926.0 5968.2 5960.6 5975.9 5977.9 5983.3 6006.5 5456.2 5473.3 5497.1 5497.3 5512.3 5428.6 5483.2 5486.4 5487.7 5489.8 5464.9 5488.9 5491.8 5497.5 5507.9 5491.4 5494.8 5507.6 5520.6 5541.1 5432.5 5477.3 5495.8 5527.9 5593.2 5951.1 6017.8 6055.3 6069.9 6094.3 6395.5 6411.1 6474.9 6485.2 6509.2 6349.4 6415.4 6436.6 6439.3 6446.1 5952.8 5953.7 5971.6 5980.2 5995.6 5685.4 6475.7 6525.9 6585.4 6667.8 6297.8 6303.9 6311.5 6389.3 6390.0 6306.8 6375.7 6421.2 6482.6 6502.0 6281.1 6307.1 6344.8 6390.6 6445.2 6024.7 6394.6 6405.0 6530.0 6548.3 5245.8 5247.5 5309.2 5341.2 5348.3 4375.1 4473.4 4477.4 4478.3 4488.8 5508.5 5512.9 5520.9 5522.8 5524.4 6441.2 6444.0 6444.1 6449.6 6452.9 5411.7 5467.5 5495.1 5510.1 5535.5 5670.6 5707.9 5756.3 5806.4 5813.7 6112.4 6208.2 6241.7 6336.1 6342.0 6466.5 6516.1 6558.2 6568.6 6571.6 6316.6 6365.0 6369.7 6392.3 6392.6 6380.5 6389.4 6426.3 6444.5 6479.2 6496.0 6521.0 6608.8 6613.2 6626.8 6115.7 6243.6 6293.7 6370.0 6382.7 6183.0 6208.6 6221.7 6225.1 6225.2 6095.7 6142.2 6149.7 6150.6 6150.7 5262.7 6280.1 6280.4 6301.9 6400.6 6097.6 6102.4 6193.5 6196.9 6199.8 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | [#1] ext.html Cycles:180 Average:36776.52 Median:34304.07 stddev:52229.79 (152.3%) stddev-sans-first:52306.40 06:07:46 INFO - PID 15367 | Values: 786.6 846.8 860.1 893.3 895.2 41641.8 43097.4 43155.6 43156.1 43206.0 38819.4 38892.0 38908.8 38974.8 39000.2 6802.3 6931.2 6933.6 6962.1 6965.1 6935.3 6989.3 7000.8 7032.2 7038.5 6940.7 6945.3 6981.5 6981.5 6987.7 6918.5 6951.0 6979.3 6984.3 7002.5 6352.7 6353.2 6411.7 6419.4 6435.8 34336.8 34386.3 34407.3 34566.7 34641.0 3341.0 3395.7 3405.8 3414.6 3414.8 27296.0 30548.2 31156.5 31476.0 31593.7 4789.0 4817.6 4883.5 4884.4 4978.5 182918.0 184124.0 185617.0 186062.0 186261.0 50190.0 50402.2 50555.0 50557.0 50839.7 53946.7 54159.5 54582.2 54643.7 54704.5 14150.2 14253.8 14358.7 14377.2 14419.6 11441.1 11537.7 11556.9 11573.4 11626.5 14693.6 14851.0 14982.0 14990.4 15023.9 5665.5 5708.5 5794.8 5809.8 5832.4 994.2 998.9 1013.4 1024.7 1032.6 22525.5 22558.4 22929.4 23039.9 23286.4 1101.0 1101.6 1108.7 1113.9 1115.8 11907.5 11934.4 12037.7 12235.9 12463.4 221242.0 222036.0 222741.0 223447.0 224598.0 52677.5 52685.7 52747.7 52754.7 52809.2 1408.6 1457.6 1470.0 1470.8 1477.7 22055.8 22084.6 22099.0 22236.4 22296.8 36945.8 37124.4 37202.8 37231.3 37299.4 192951.0 193350.0 193615.0 193887.0 193973.0 31812.7 34944.3 35682.3 35688.8 35845.0 44047.1 44233.6 44276.1 45002.6 45419.0 29637.4 31171.7 31875.0 32283.5 32446.5 30702.8 30997.5 31482.0 32094.0 32303.4 34233.3 34271.3 34403.8 34561.8 34611.1 30381.0 30517.8 30755.7 31054.7 31076.2 22142.3 22950.7 23049.4 23213.4 23393.6 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | [#2] jquery.html Cycles:180 Average:34286.26 Median:12803.48 stddev:83493.35 (652.1%) stddev-sans-first:83689.18 06:07:46 INFO - PID 15367 | Values: 564.8 567.5 568.8 585.3 600.3 21140.3 22036.9 22189.8 22211.4 22233.3 24378.3 25491.1 25792.2 26934.3 27216.9 6421.3 6610.7 6626.6 6649.6 6659.7 6569.2 6635.5 6638.3 6641.0 6645.8 4024.9 4771.8 5939.6 6479.8 6581.5 6527.7 6557.3 6588.8 6597.9 6608.3 6123.8 6135.8 6141.3 6165.7 6173.7 27522.4 29021.0 29453.3 29489.0 29514.3 1952.6 1985.3 2001.1 2004.2 2009.2 18562.5 19155.5 19158.9 19172.7 19182.2 2327.8 2361.2 2417.0 2420.8 2430.1 133339.0 134797.0 136566.0 138059.0 138111.3 14243.6 14656.2 14739.4 14986.9 15017.8 23279.2 23404.2 23543.2 23547.3 23574.4 9661.4 9698.3 9802.3 9836.9 9886.2 8840.5 8902.5 8926.8 9005.5 9100.9 8871.2 9110.1 9233.0 9431.7 9548.3 2706.4 2781.9 2786.8 2799.5 2932.5 948.4 962.6 971.8 997.5 1000.8 19516.2 19568.0 19585.2 20104.2 20194.1 1004.9 1020.6 1048.8 1052.6 1057.9 10689.2 10709.9 10829.1 10907.0 11295.8 482205.0 494750.0 504430.0 505114.0 510427.0 98391.5 100546.5 102161.5 102231.5 103043.5 1185.9 1204.1 1222.8 1224.2 1234.6 16827.2 17866.4 17872.1 18331.9 18373.4 51120.0 52693.5 52826.0 53032.7 53357.5 62699.4 62918.7 63029.4 63049.0 63425.7 14923.5 14988.3 14990.5 15077.5 15104.7 22413.0 22855.5 22922.5 22978.2 23268.5 18057.5 18106.6 19138.2 19152.9 19412.4 17092.6 17310.6 17645.0 18161.1 18486.8 19717.5 19859.3 20085.8 20091.3 20101.5 14745.6 14767.6 15206.2 15207.3 15237.2 18755.3 19337.0 19363.5 19379.6 19431.5 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | [#3] mootools.html Cycles:180 Average:8270.17 Median:2510.67 stddev:5454.69 (217.3%) stddev-sans-first:5445.27 06:07:46 INFO - PID 15367 | Values: 1359.7 1411.0 1417.1 1419.7 1421.3 12888.3 13670.5 13679.7 13740.6 13767.6 13072.4 13535.8 13559.7 13570.7 13571.3 2548.8 2553.8 2565.7 2578.1 2586.8 2485.5 2538.4 2564.3 2572.4 2576.4 2500.6 2520.7 2535.2 2549.4 2568.5 2411.5 2425.2 2428.4 2429.7 2440.9 2340.6 2392.2 2398.8 2415.0 2415.4 12905.7 13179.9 13223.1 13242.1 13258.9 7077.9 7318.5 7338.0 7345.4 7348.2 4951.8 4972.3 5069.9 5156.7 5171.0 1866.6 1872.6 1878.0 1926.4 1933.1 20450.0 20623.8 20643.2 20712.6 21226.3 5649.4 6263.2 6507.4 6541.7 6545.4 15060.5 15082.3 15117.2 15156.6 15171.6 6995.6 7234.6 7237.6 7258.9 7272.1 6842.0 6900.9 6931.3 6954.4 6987.8 4923.5 5047.3 5117.9 5126.6 5132.1 1425.7 1454.5 1464.0 1465.0 1483.8 862.4 868.1 868.8 899.7 904.9 6894.9 7068.0 7090.8 7105.4 7144.0 692.4 712.5 717.4 718.9 727.9 4502.9 4799.4 4958.9 5000.0 5126.7 17072.9 17455.3 17616.1 17619.2 17636.8 17079.6 17211.7 17400.1 17406.7 17593.2 9165.3 9567.0 10190.7 10245.9 10267.0 8035.8 8179.3 8212.5 8308.7 8314.3 14991.0 15733.3 15771.7 15988.4 16341.1 15495.8 15896.0 16174.6 16328.9 16379.5 11113.8 11244.6 11393.2 11432.5 11539.4 12745.7 12935.2 12977.3 12994.5 13034.3 9818.3 10258.1 10374.9 10691.0 10694.5 9888.5 9973.5 9977.6 10029.0 10104.4 9344.2 9414.1 9450.6 9501.2 9516.8 6917.9 7081.3 7232.0 7259.9 7265.8 6764.3 7183.5 7193.0 7204.5 7268.4 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | [#4] prototype.html Cycles:180 Average:5417.40 Median:5967.83 stddev:1517.11 (25.4%) stddev-sans-first:1475.62 06:07:46 INFO - PID 15367 | Values: 491.0 507.6 520.4 528.4 531.4 6008.8 6012.9 6140.3 6147.6 6166.7 5853.5 5901.6 5970.5 5994.7 6059.3 4817.9 4818.4 4885.8 4896.2 4931.7 4858.6 4883.8 4886.3 4897.0 4918.1 4856.5 4884.9 4886.7 4904.1 4906.9 4657.9 4802.7 4810.9 4878.9 4890.2 4339.6 4395.0 4400.7 4404.3 4404.4 5934.9 5949.2 5965.2 5991.0 5999.7 5517.9 5534.9 5564.5 5603.6 5605.0 6380.3 6399.2 6469.4 6474.2 6489.6 4805.7 4819.8 4832.8 4839.6 4871.9 6704.4 6723.4 6782.8 6785.2 6810.1 4973.5 4978.5 4981.8 4996.0 5000.9 5017.0 5024.8 5050.3 5054.2 5075.2 5591.4 5593.8 5594.6 5620.0 5643.4 6441.8 6456.4 6480.8 6504.3 6540.9 1740.8 1751.3 1756.6 1775.2 1778.4 1135.9 1214.1 1226.3 1239.5 1240.7 5423.5 5443.5 5558.4 5608.3 5618.7 6560.9 6595.4 6648.8 6663.1 6701.4 5587.6 5610.7 5650.5 5670.3 5685.2 3437.8 3505.2 3530.4 3559.8 3580.2 6470.9 6490.5 6504.3 6516.4 6552.2 6848.5 6853.0 6855.6 6857.1 6896.8 6388.8 6399.0 6435.9 6475.8 6503.9 6566.9 6593.3 6610.2 6645.3 6664.6 6409.3 6428.7 6488.7 6513.8 6529.9 6343.2 6370.4 6412.6 6436.5 6453.0 4871.0 4915.3 4925.7 4925.8 4941.7 6607.2 6632.8 6679.3 6692.6 6730.4 6359.0 6389.8 6428.5 6449.3 6487.5 6407.6 6424.2 6427.1 6430.2 6481.7 6226.5 6289.0 6297.5 6369.1 6415.4 5913.6 6298.4 6345.9 6455.8 6497.9 6205.5 6212.6 6226.5 6290.3 6342.5 06:07:46 INFO - PID 15367 | 06:07:46 INFO - PID 15367 | [#5] yui.html Cycles:180 Average:22704.76 Median:19777.30 stddev:30712.63 (155.3%) stddev-sans-first:30755.18 06:07:46 INFO - PID 15367 | Values: 908.8 910.1 914.9 924.0 930.3 18038.4 18771.8 18778.0 18895.7 18905.6 20113.8 21461.2 21537.7 21686.8 21833.9 1001.7 1024.0 1026.5 1030.5 1034.3 767.6 1024.8 1027.5 1031.7 1033.3 831.6 1074.9 1096.4 1101.8 1113.0 1088.5 1089.4 1089.8 1090.2 1094.5 790.9 793.2 794.1 795.0 795.1 17947.3 17976.3 19901.8 20218.8 20249.4 18608.9 18805.5 19062.9 19233.3 19498.2 15709.2 16023.7 16237.6 16273.7 16287.0 3528.8 3534.5 3547.7 3550.1 3553.1 117908.9 118880.0 122748.4 125551.0 126254.7 14838.7 15068.4 15085.9 15089.7 15280.4 25961.7 27767.7 27867.4 28004.0 28063.7 7537.2 7676.1 7734.7 7792.9 7850.1 3926.2 3965.8 3986.7 4013.4 4024.0 5000.3 5034.9 5117.8 5153.5 5177.5 892.4 921.5 923.6 926.8 929.1 670.5 674.4 677.8 691.3 717.2 11099.6 11353.7 11445.8 11459.7 11581.6 627.0 627.0 650.1 652.3 661.6 4921.7 5126.9 5196.6 5202.2 5231.8 98768.5 102761.0 104285.5 105303.0 106184.0 91471.5 91652.0 93345.0 94299.0 96151.0 80055.2 80634.2 82858.2 83724.6 84237.0 10106.5 10131.7 10195.9 10355.1 11010.8 35609.1 36804.3 37356.1 37484.8 38978.6 64046.4 65774.3 66987.0 67542.7 71198.6 18459.0 18469.5 18613.3 18771.3 18926.3 19442.5 19652.8 20487.5 20674.9 21161.7 17330.7 17722.6 17814.0 18038.7 18104.5 18791.9 19020.8 19253.9 19274.8 19593.9 17105.9 17713.6 17732.0 18033.6 18069.5 11912.9 12409.0 12518.2 12534.5 12573.9 12428.5 12741.2 13110.8 13616.5 14216.8 06:07:46 INFO - PID 15367 | -------- Summary: end -------- 06:07:46 INFO - PID 15367 | 06:07:47 INFO - TEST-INFO | 15367: exit 0 06:07:47 INFO - TEST-OK | dromaeo_css | took 1110952ms 06:07:47 INFO - TEST-START | kraken 06:07:47 INFO - Initialising browser for kraken test... 06:07:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html -profile /tmp/tmphfVcI8/profile 06:07:47 INFO - TEST-INFO | started process 15781 (/builds/slave/test/build/application/firefox/firefox http://localhost:58569/getInfo.html) 06:07:53 INFO - TEST-INFO | 15781: exit 0 06:07:53 INFO - Browser initialized. 06:07:53 INFO - Running cycle 1/1 for kraken test... 06:07:53 INFO - TEST-INFO | started process 16004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfVcI8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:05 INFO - PID 16004 | RSS: Main: 169582592 06:08:05 INFO - PID 16004 | 06:08:07 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:08 INFO - PID 16004 | RSS: Main: 176734208 06:08:08 INFO - PID 16004 | 06:08:11 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-dft) 06:08:11 INFO - PID 16004 | RSS: Main: 176488448 06:08:11 INFO - PID 16004 | 06:08:14 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-fft) 06:08:15 INFO - PID 16004 | RSS: Main: 170307584 06:08:15 INFO - PID 16004 | 06:08:17 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58569/tests/kraken/driver.html?testName=audio-oscillator) 06:08:17 INFO - PID 16004 | RSS: Main: 171618304 06:08:17 INFO - PID 16004 | 06:08:20 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:20 INFO - PID 16004 | RSS: Main: 171909120 06:08:20 INFO - PID 16004 | 06:08:23 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58569/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:24 INFO - PID 16004 | RSS: Main: 174473216 06:08:24 INFO - PID 16004 | 06:08:27 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58569/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:28 INFO - PID 16004 | RSS: Main: 176410624 06:08:28 INFO - PID 16004 | 06:08:31 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58569/tests/kraken/driver.html?testName=json-parse-financial) 06:08:31 INFO - PID 16004 | RSS: Main: 175308800 06:08:31 INFO - PID 16004 | 06:08:33 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:34 INFO - PID 16004 | RSS: Main: 175706112 06:08:34 INFO - PID 16004 | 06:08:35 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:36 INFO - PID 16004 | RSS: Main: 175751168 06:08:36 INFO - PID 16004 | 06:08:38 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:39 INFO - PID 16004 | RSS: Main: 175079424 06:08:39 INFO - PID 16004 | 06:08:41 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:42 INFO - PID 16004 | RSS: Main: 175071232 06:08:42 INFO - PID 16004 | 06:08:45 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:46 INFO - PID 16004 | RSS: Main: 175280128 06:08:46 INFO - PID 16004 | 06:08:47 INFO - PID 16004 | Cycle 1(1): loaded http://localhost:58569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58569/tests/kraken/driver.html?testName=ai-astar) 06:08:48 INFO - PID 16004 | RSS: Main: 176590848 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | __start_tp_report 06:08:48 INFO - PID 16004 | _x_x_mozilla_page_load 06:08:48 INFO - PID 16004 | _x_x_mozilla_page_load_details 06:08:48 INFO - PID 16004 | |i|pagename|runs| 06:08:48 INFO - PID 16004 | |0;ai-astar;101;109;108;108;108;110;108;109;109;112 06:08:48 INFO - PID 16004 | |1;audio-beat-detection;145;120;147;180;122;151;146;126;184;122 06:08:48 INFO - PID 16004 | |2;audio-dft;162;161;162;162;162;167;162;161;171;163 06:08:48 INFO - PID 16004 | |3;audio-fft;74;76;75;169;77;73;76;76;100;75 06:08:48 INFO - PID 16004 | |4;audio-oscillator;83;81;131;80;82;80;134;82;81;131 06:08:48 INFO - PID 16004 | |5;imaging-gaussian-blur;114;113;114;114;114;113;113;113;114;113 06:08:48 INFO - PID 16004 | |6;imaging-darkroom;149;148;149;149;149;152;149;150;155;151 06:08:48 INFO - PID 16004 | |7;imaging-desaturate;94;94;95;95;94;94;94;96;94;94 06:08:48 INFO - PID 16004 | |8;json-parse-financial;54;58;59;54;63;62;57;54;55;58 06:08:48 INFO - PID 16004 | |9;json-stringify-tinderbox;55;55;53;54;54;53;54;54;55;55 06:08:48 INFO - PID 16004 | |10;stanford-crypto-aes;77;84;86;78;87;77;77;77;86;77 06:08:48 INFO - PID 16004 | |11;stanford-crypto-ccm;131;129;125;136;128;137;130;125;126;159 06:08:48 INFO - PID 16004 | |12;stanford-crypto-pbkdf2;182;187;189;186;187;185;185;182;182;189 06:08:48 INFO - PID 16004 | |13;stanford-crypto-sha256-iterative;69;74;79;68;73;72;70;69;72;69 06:08:48 INFO - PID 16004 | __end_tp_report 06:08:48 INFO - PID 16004 | __start_cc_report 06:08:48 INFO - PID 16004 | _x_x_mozilla_cycle_collect,936 06:08:48 INFO - PID 16004 | __end_cc_report 06:08:48 INFO - PID 16004 | __startTimestamp1500296928161__endTimestamp 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | ------- Summary: start ------- 06:08:48 INFO - PID 16004 | Number of tests: 14 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.00 stddev:2.82 (2.6%) stddev-sans-first:1.32 06:08:48 INFO - PID 16004 | Values: 101.0 109.0 108.0 108.0 108.0 110.0 108.0 109.0 109.0 112.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:146.50 stddev:23.16 (15.8%) stddev-sans-first:24.56 06:08:48 INFO - PID 16004 | Values: 145.0 120.0 147.0 180.0 122.0 151.0 146.0 126.0 184.0 122.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.00 stddev:3.20 (2.0%) stddev-sans-first:3.36 06:08:48 INFO - PID 16004 | Values: 162.0 161.0 162.0 162.0 162.0 167.0 162.0 161.0 171.0 163.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.50 stddev:29.83 (39.5%) stddev-sans-first:31.26 06:08:48 INFO - PID 16004 | Values: 74.0 76.0 75.0 169.0 77.0 73.0 76.0 76.0 100.0 75.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:81.00 stddev:24.53 (30.3%) stddev-sans-first:25.52 06:08:48 INFO - PID 16004 | Values: 83.0 81.0 131.0 80.0 82.0 80.0 134.0 82.0 81.0 131.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:08:48 INFO - PID 16004 | Values: 114.0 113.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:149.50 stddev:2.08 (1.4%) stddev-sans-first:2.17 06:08:48 INFO - PID 16004 | Values: 149.0 148.0 149.0 149.0 149.0 152.0 149.0 150.0 155.0 151.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 06:08:48 INFO - PID 16004 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 96.0 94.0 94.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:3.27 (5.6%) stddev-sans-first:3.23 06:08:48 INFO - PID 16004 | Values: 54.0 58.0 59.0 54.0 63.0 62.0 57.0 54.0 55.0 58.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 06:08:48 INFO - PID 16004 | Values: 55.0 55.0 53.0 54.0 54.0 53.0 54.0 54.0 55.0 55.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:4.50 (5.6%) stddev-sans-first:4.58 06:08:48 INFO - PID 16004 | Values: 77.0 84.0 86.0 78.0 87.0 77.0 77.0 77.0 86.0 77.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:130.50 stddev:10.17 (7.8%) stddev-sans-first:10.77 06:08:48 INFO - PID 16004 | Values: 131.0 129.0 125.0 136.0 128.0 137.0 130.0 125.0 126.0 159.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:186.50 stddev:2.72 (1.5%) stddev-sans-first:2.59 06:08:48 INFO - PID 16004 | Values: 182.0 187.0 189.0 186.0 187.0 185.0 185.0 182.0 182.0 189.0 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:72.00 stddev:3.31 (4.6%) stddev-sans-first:3.38 06:08:48 INFO - PID 16004 | Values: 69.0 74.0 79.0 68.0 73.0 72.0 70.0 69.0 72.0 69.0 06:08:48 INFO - PID 16004 | -------- Summary: end -------- 06:08:48 INFO - PID 16004 | 06:08:48 INFO - PID 16004 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:08:48 INFO - TEST-INFO | 16004: exit 0 06:08:48 INFO - TEST-OK | kraken | took 61649ms 06:08:48 INFO - SUITE-END | took 1172s 06:08:49 INFO - Completed test suite (00:19:32) 06:08:49 INFO - javascript benchmark 06:08:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8217.44120288782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.0, 3112.953305700414, 3143.0, 3149.527570864371, 3155.069254569903, 5888.0, 5897.941020589793, 5910.438508341701, 5926.0, 5968.1644569760265, 5960.5529585281065, 5975.850603734909, 5977.850553736148, 5983.311919129302, 6006.489448396892, 5456.208849716789, 5473.31583552056, 5497.147942068966, 5497.312835895503, 5512.33851937766, 5428.647137936041, 5483.150111732668, 5486.423925487826, 5487.725613719298, 5489.835304940858, 5464.9453505465035, 5488.862778430531, 5491.835244942658, 5497.505224529791, 5507.862303442406, 5491.368492623359, 5494.780208791643, 5507.614466987313, 5520.585956053312, 5541.085720856054, 5432.511074003319, 5477.260569823103, 5495.752691128869, 5527.917081243784, 5593.216949627055, 5951.107333899907, 6017.849553761147, 6055.303640081359, 6069.908951365733, 6094.268687757498, 6395.456386207178, 6411.070394792776, 6474.935250647527, 6485.156929599169, 6509.1863517060365, 6349.396807303298, 6415.358464153594, 6436.645984470852, 6439.323870993572, 6446.065320528544, 5952.761889524414, 5953.702314884238, 5971.641701497924, 5980.162777211194, 5995.640261584319, 5685.449957947871, 6475.708593113368, 6525.902111468332, 6585.440237579859, 6667.766628167991, 6297.779577714758, 6303.905441418382, 6311.495080393557, 6389.329120442287, 6390.0, 6306.810795676045, 6375.71309291083, 6421.165248517663, 6482.57863238888, 6502.0, 6281.057841323838, 6307.053941908659, 6344.841378965562, 6390.584612000205, 6445.1621289233035, 6024.698765061729, 6394.584352017104, 6404.967975160188, 6530.0, 6548.27968923418, 5245.842624721265, 5247.501487358695, 5309.203619457112, 5341.172118321666, 5348.251244825728, 4375.124975005012, 4473.4408198975125, 4477.395551600493, 4478.328250762412, 4488.820447182142, 5508.531774799187, 5512.944870551323, 5520.944790552124, 5522.834314970557, 5524.392316845144, 6441.227052753699, 6444.033394990789, 6444.130042444303, 6449.580777249464, 6452.935470645233, 5411.729413529387, 5467.507924286833, 5495.065838807413, 5510.0632892408385, 5535.474129957647, 5670.631408958405, 5707.857303567444, 5756.3380211276235, 5806.44838740319, 5813.680247586423, 6112.388761123852, 6208.161898143783, 6241.7191226394925, 6336.112944187817, 6341.968290158519, 6466.450351719968, 6516.087747715229, 6558.1802274715665, 6568.6058836469965, 6571.605703657796, 6316.557840951273, 6365.045243213555, 6369.7452101915405, 6392.296847346881, 6392.648404337806, 6380.489560835029, 6389.393007664265, 6426.260979987174, 6444.484441244783, 6479.222493300834, 6496.0, 6521.0, 6608.801735947929, 6613.2394774601535, 6626.83432914181, 6115.663638499926, 6243.562950593415, 6293.716782744696, 6370.044493326038, 6382.680865956777, 6183.0, 6208.565400422108, 6221.720022599085, 6225.097360882556, 6225.190725205694, 6095.664738439428, 6142.170806941006, 6149.692515374124, 6150.600210986271, 6150.723217455135, 5262.710550919736, 6280.057991301342, 6280.434760871543, 6301.936980630318, 6400.583962042452, 6097.5731698780655, 6102.420270074336, 6193.504519638508, 6196.938030619636, 6199.845003874939], "value": 5867.277012398761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.6224212378058, 846.7586737779734, 860.0582362313266, 893.2630579771686, 895.180909467837, 41641.79179104104, 43097.35353969685, 43155.568444315584, 43156.136877262434, 43206.0, 38819.41770873439, 38892.02769930753, 38908.80545597275, 38974.8051259744, 39000.21999560007, 6802.285759995191, 6931.2375638679705, 6933.583984960893, 6962.1297337832775, 6965.129358830146, 6935.271796461375, 6989.266127056637, 7000.754973575926, 7032.191298000745, 7038.5424947378515, 6940.652967351637, 6945.270746571613, 6981.4763892708, 6981.5461994970165, 6987.650617469131, 6918.515703900729, 6951.0, 6979.336962988534, 6984.301569843001, 7002.47481438889, 6352.650604216767, 6353.174087368659, 6411.67941602918, 6419.390157934989, 6435.8391040223905, 34336.82831585851, 34386.31227375464, 34407.31185376278, 34566.654333456594, 34641.0, 3340.9832950835334, 3395.6774106459848, 3405.8126803025825, 3414.6243913169533, 3414.778039427454, 27296.0, 30548.236294092603, 31156.53265201024, 31476.0, 31593.684063159533, 4788.95211047892, 4817.638677099231, 4883.4628190898975, 4884.3650325457465, 4978.5270399312, 182918.0, 184124.0, 185616.99999999866, 186062.0, 186261.0, 50190.0, 50402.24396634053, 50555.0, 50557.0, 50839.74580127076, 53946.730266348415, 54159.458405416226, 54582.18126728102, 54643.72678136584, 54704.45295546993, 14150.150990940576, 14253.78619320711, 14358.712825743636, 14377.20925349095, 14419.639509012359, 11441.141914356456, 11537.711557211136, 11556.88443115575, 11573.363465009337, 11626.476808543466, 14693.55919322422, 14851.0, 14982.0, 14990.400383984519, 15023.948323617242, 5665.49010589049, 5708.543316534668, 5794.797182098607, 5809.7966571170655, 5832.387599302012, 994.179801663616, 998.8601595776597, 1013.4020927652573, 1024.7386916336436, 1032.5972870580329, 22525.54948901013, 22558.436039099153, 22929.426764331027, 23039.88480057589, 23286.417839553807, 1100.9504572294265, 1101.6254473479055, 1108.711734948919, 1113.9164562657834, 1115.827046807746, 11907.464164112636, 11934.428154214105, 12037.699057523458, 12235.938820306019, 12463.439145238304, 221242.0, 222036.0, 222741.0, 223447.0, 224598.0, 52677.473225267255, 52685.7365713169, 52747.736261319216, 52754.73622631862, 52809.2078618821, 1408.64783804049, 1457.6210185351672, 1469.9632509187356, 1470.7573250413561, 1477.697072100217, 22055.779442206014, 22084.558308834054, 22099.0, 22236.444088897908, 22296.77703222947, 36945.81527092347, 37124.443133352484, 37202.8139859299, 37231.25537489289, 37299.440508391854, 192951.0, 193350.0, 193615.0, 193887.0, 193973.0, 31812.681873180973, 34944.30111397707, 35682.28635427225, 35688.82155589309, 35845.028523431465, 44047.11905761931, 44233.55766442423, 44276.11447771091, 45002.64992050244, 45419.0, 29637.407251855275, 31171.688283116877, 31875.0, 32283.51574726428, 32446.513302300955, 30702.84648576743, 30997.53503697401, 31482.0, 32094.0, 32303.35393292074, 34233.31533369368, 34271.31457370789, 34403.82798085993, 34561.827190863885, 34611.13472163216, 30381.0, 30517.847410762803, 30755.69244307618, 31054.68945310518, 31076.22309442282, 22142.335729928127, 22950.655740164246, 23049.423764406023, 23213.41966450852, 23393.649095263925], "value": 16608.707958401235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.8305508347495, 567.5034344948173, 568.7525926222094, 585.29179692572, 600.2526854066687, 21140.2600908968, 22036.89815509226, 22189.778102218974, 22211.44471388216, 22233.333000010007, 24378.26865194047, 25491.10781122661, 25792.226233212987, 26934.326641833963, 27216.863915680442, 6421.325760795119, 6610.669466526654, 6626.635535045571, 6649.60102393858, 6659.733610655592, 6569.178852643419, 6635.469162466991, 6638.302978187269, 6641.037049627801, 6645.767398141066, 4024.899377515571, 4771.785269662873, 5939.55453340999, 6479.805605831809, 6581.506387020969, 6527.706253218616, 6557.278699343068, 6588.769393071243, 6597.9340206598035, 6608.2730899601, 6123.755049798003, 6135.815925522242, 6141.324454310023, 6165.691715414257, 6173.660448675321, 27522.449551009067, 29021.0, 29453.263668408246, 29489.0, 29514.262143446373, 1952.5509132899372, 1985.2753744883157, 2001.0595020340418, 2004.1582535335194, 2009.2264478175862, 18562.53593660156, 19155.52111197217, 19158.904205479022, 19172.71240931387, 19182.232710691555, 2327.767223277676, 2361.244401791427, 2416.9516609667708, 2420.770026847447, 2430.1008626808016, 133339.0, 134797.0, 136566.0, 138059.0, 138111.30944345213, 14243.64390890236, 14656.193909335088, 14739.410423583151, 14986.925065374604, 15017.849821501864, 23279.18522851692, 23404.18085367004, 23543.175988840307, 23547.293581192593, 23574.410639734146, 9661.3614953642, 9698.272629552812, 9802.313838031412, 9836.931602974213, 9886.209103271722, 8840.469571825712, 8902.483519010084, 8926.821463570823, 9005.504697241584, 9100.908990910139, 8871.201591856634, 9110.088991100969, 9233.0, 9431.717048488556, 9548.331616786898, 2706.4045909900183, 2781.8887244510397, 2786.8327900326044, 2799.468101060792, 2932.4574953633646, 948.4309414351472, 962.6005207838808, 971.8007808399261, 997.5361456922566, 1000.8298589239847, 19516.21935122579, 19568.0, 19585.223590408354, 20104.195832166843, 20194.091265892777, 1004.924630652704, 1020.642775028734, 1048.764028093688, 1052.5737076484036, 1057.9153667706564, 10689.198310126772, 10709.892901070889, 10829.133669306437, 10907.018368346888, 11295.830562541569, 482205.0, 494750.0, 504430.0, 505114.0, 510427.0, 98391.50804245933, 100546.4972675132, 102161.48919255356, 102231.4888425568, 103043.4847825756, 1185.9229150105216, 1204.1209916760638, 1222.8104643780227, 1224.240970598217, 1234.6357824441811, 16827.158642068094, 17866.374676886247, 17872.106394680475, 18331.908340458747, 18373.448796536126, 51120.0, 52693.47306527039, 52826.0, 53032.73483632557, 53357.46642533525, 62699.37300626935, 62918.68540657451, 63029.36970630235, 63049.0, 63425.68287158535, 14923.477678281208, 14988.325525351167, 14990.47533336328, 15077.472288469851, 15104.697906042038, 22413.0, 22855.542889142456, 22922.54154916859, 22978.195763148877, 23268.53462930698, 18057.54856128555, 18106.637867242844, 19138.23447062102, 19152.90423547929, 19412.417627471197, 17092.626398920333, 17310.5672358187, 17645.0, 18161.09194540241, 18486.81513184851, 19717.507062323555, 19859.30492432758, 20085.79914200898, 20091.296804611768, 20101.49746256355, 14745.631359216106, 14767.630809229855, 15206.239688015776, 15207.315670795062, 15237.238138093273, 18755.34356297523, 19337.0, 19363.51591210231, 19379.612407752047, 19431.5426343022], "value": 11869.374118218506, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.734851703918, 1410.992945035275, 1417.0505761140034, 1419.701862608852, 1421.2538417330893, 12888.291143987077, 13670.453181872737, 13679.726405471885, 13740.58778236652, 13767.58697239082, 13072.411741471633, 13535.796963045563, 13559.72880542391, 13570.728585428285, 13571.253581053063, 2548.808839337057, 2553.757393047667, 2565.6536367590415, 2578.123438031069, 2586.8059895507818, 2485.515324511721, 2538.4288535079645, 2564.3204550794053, 2572.4083460804027, 2576.3559110222445, 2500.6374075759004, 2520.7101183363966, 2535.1760677779703, 2549.413634863973, 2568.4863027394595, 2411.4694767151286, 2425.1754403502805, 2428.3807629054477, 2429.7327293997646, 2440.890159942807, 2340.566995105911, 2392.234484964812, 2398.832081754278, 2415.0, 2415.384077060356, 12905.741885162339, 13179.86820131796, 13223.140495867738, 13242.139260948104, 13258.933705331508, 7077.929220707779, 7318.487705860592, 7338.0, 7345.375643070345, 7348.191698913115, 4951.752412379403, 4972.328735620681, 5069.923951140736, 5156.716380599066, 5170.9741451292875, 1866.6266746650588, 1872.5599484121221, 1878.042198478772, 1926.412444204517, 1933.0721253798256, 20449.977501124886, 20623.793762062338, 20643.17427302906, 20712.58574828495, 21226.25708100209, 5649.378568357477, 6263.154474146023, 6507.446867016357, 6541.705623246965, 6545.4436372907885, 15060.472883449245, 15082.321295541728, 15117.16855572954, 15156.621084472976, 15171.620709482351, 6995.580265184105, 7234.5659260444545, 7237.565746055148, 7258.854822903512, 7272.127344718668, 6842.04211410403, 6900.861982760317, 6931.272216417305, 6954.4436445084275, 6987.755428560077, 4923.507649235048, 5047.268146118792, 5117.8720531986255, 5126.5898728101665, 5132.0762262792305, 1425.6720954180596, 1454.4909281751513, 1463.9707205855823, 1464.985350146506, 1483.8441963593882, 862.4307956748515, 868.1015149320549, 868.8001759595202, 899.7255836969656, 904.8552231642906, 6894.896576551356, 7067.964660176666, 7090.787276381717, 7105.43156547475, 7144.0, 692.3906961873519, 712.4870093532649, 717.4224749077043, 718.9496735228588, 727.8580676768086, 4502.932456013163, 4799.400074990626, 4958.851234462972, 4999.950000500021, 5126.666766660155, 17072.914635426743, 17455.30178792834, 17616.119194040246, 17619.207135678924, 17636.823631763516, 17079.573010674834, 17211.655766884593, 17400.129993500275, 17406.738898916527, 17593.208305626278, 9165.266778657691, 9567.0, 10190.694279171637, 10245.897541024644, 10267.0, 8035.758927232192, 8179.304759095544, 8212.548309843016, 8308.6676532938, 8314.251717345225, 14991.0, 15733.292001860173, 15771.684566308839, 15988.360465581713, 16341.101239431946, 15495.767563486332, 15896.04623722534, 16174.595635108746, 16328.918355408146, 16379.508614741577, 11113.833292500458, 11244.55021799119, 11393.202475826612, 11432.485538150637, 11539.423028848356, 12745.681357966125, 12935.159214651394, 12977.286249256003, 12994.48022079144, 13034.283114428797, 9818.263630227904, 10258.076773090457, 10374.948125259325, 10691.0, 10694.518746656575, 9888.473278315496, 9973.501324933579, 9977.600895964371, 10029.04724051214, 10104.444255566015, 9344.15902568772, 9414.058594140532, 9450.621975120917, 9501.239900807781, 9516.762080948032, 6917.9308206917285, 7081.327273908971, 7231.963840180976, 7259.891101633585, 7265.782026539212, 6764.255931847394, 7183.5330703504105, 7193.0, 7204.459665525002, 7268.382187513909], "value": 6077.437301267802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.0, 507.60914096145956, 520.4405264340834, 528.3554064041867, 531.3570579598688, 6008.849778755528, 6012.939870601293, 6140.26316841979, 6147.616786223098, 6166.722497487613, 5853.531717462603, 5901.586888917777, 5970.462658360747, 5994.730237139328, 6059.272887253535, 4817.940053188293, 4818.445878723939, 4885.780139893695, 4896.167651499253, 4931.704097754128, 4858.587020103296, 4883.804647814083, 4886.267059941002, 4897.0, 4918.114739346916, 4856.465788763251, 4884.925316430397, 4886.706797592155, 4904.092742842586, 4906.9263961040615, 4657.86026419208, 4802.687825291362, 4810.903781924342, 4878.902421951541, 4890.217565189588, 4339.60943515082, 4394.956050439487, 4400.669949753781, 4404.295312749945, 4404.4494438195225, 5934.940650593482, 5949.226600541945, 5965.194698715662, 5990.97004514979, 5999.650078732294, 5517.917231241535, 5534.889302213933, 5564.4991950724625, 5603.635763675389, 5604.971975140098, 6380.298167201604, 6399.168108145911, 6469.385408386196, 6474.223093228796, 6489.610623362566, 4805.663603547753, 4819.795051237191, 4832.806687732486, 4839.564439200489, 4871.8782030449165, 6704.363085506869, 6723.428508576826, 6782.762603308861, 6785.2196997345445, 6810.114685090906, 4973.502649734997, 4978.452370239271, 4981.800727970913, 4995.975020124876, 5000.9498005418545, 5017.0, 5024.799008039638, 5050.267711181858, 5054.241863720471, 5075.187969924795, 5591.384947655754, 5593.8321850344555, 5594.580406469531, 5620.0, 5643.435656434323, 6441.838954026093, 6456.418922297016, 6480.837979050561, 6504.317046710122, 6540.9345906541275, 1740.8346207110305, 1751.3099858636222, 1756.604763928106, 1775.2100315359542, 1778.404234581404, 1135.9204855660025, 1214.1197631716934, 1226.3316492511603, 1239.4856134704178, 1240.7084335181225, 5423.538999185113, 5443.510084092451, 5558.360788509292, 5608.298962629671, 5618.69097199658, 6560.901586476207, 6595.406413422815, 6648.83377915556, 6663.13379260693, 6701.39687428124, 5587.580931430159, 5610.72765529961, 5650.5479561634975, 5670.262865827416, 5685.1756495307945, 3437.7765445245977, 3505.158761897126, 3530.4051522131213, 3559.7864128151878, 3580.1944562473236, 6470.870582588416, 6490.545661803629, 6504.252011018793, 6516.446102081281, 6552.180977377828, 6848.459096703202, 6853.0, 6855.5886646801355, 6857.142857142857, 6896.793096207121, 6388.79586542642, 6399.048290271418, 6435.871282574322, 6475.805725828232, 6503.902441463382, 6566.868662626816, 6593.307702691149, 6610.2398224204835, 6645.269020407654, 6664.600123992576, 6409.262934762562, 6428.710708018057, 6488.70800813974, 6513.804585862432, 6529.869402611826, 6343.207099112611, 6370.426661600478, 6412.645441056583, 6436.549441539048, 6452.967525195946, 4870.951290487192, 4915.26271059344, 4925.655204135819, 4925.773618280033, 4941.68906832416, 6607.161587756649, 6632.767853125118, 6679.332066793282, 6692.59844409337, 6730.394264516217, 6358.968205158944, 6389.827458664076, 6428.453581445442, 6449.290578036506, 6487.481001519773, 6407.583507072025, 6424.229092508929, 6427.132337134614, 6430.228372595318, 6481.675916204265, 6226.533010024175, 6288.993760998218, 6297.4647154992335, 6369.14016607752, 6415.422611964946, 5913.58604897653, 6298.401651843067, 6345.90481142774, 6455.771469687363, 6497.902531462127, 6205.47253483459, 6212.63322069144, 6226.533010024357, 6290.2766181889665, 6342.460890824332], "value": 4975.541283151796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.8318661047707, 910.1262787723789, 914.9130832570903, 924.0251534630962, 930.3069213435991, 18038.368657096988, 18771.812281877177, 18777.967211803363, 18895.716564251547, 18905.62188756224, 20113.798862011376, 21461.248856290033, 21537.67693484599, 21686.783132168675, 21833.890830545824, 1001.7445551384405, 1023.9692809215735, 1026.4764969865385, 1030.510507508931, 1034.270839058462, 767.6200280860982, 1024.795040991801, 1027.4913917610793, 1031.736907088695, 1033.2508931024984, 831.5717405536154, 1074.8710154781397, 1096.3915027159962, 1101.8347247912798, 1112.9777404451906, 1088.472091035851, 1089.4008295437557, 1089.8310761831929, 1090.236834216044, 1094.5129417409255, 790.8734602463578, 793.1949071692237, 794.1145622630725, 794.9983021393028, 795.1372760554805, 17947.282108715637, 17976.280948762032, 19901.800981990138, 20218.79781202184, 20249.39251822433, 18608.90695546527, 18805.529861753566, 19062.904685476486, 19233.326833560757, 19498.220071197135, 15709.214539273105, 16023.679526409524, 16237.594060148473, 16273.674526509521, 16287.0, 3528.770629909048, 3534.4874993125854, 3547.7161827053774, 3550.1124718820297, 3553.076200187944, 117908.87318943796, 118880.0, 122748.38625806815, 125551.0, 126254.73745262521, 14838.703225935637, 15068.397264109313, 15085.94398392102, 15089.698206035819, 15280.388784448498, 25961.740382595934, 27767.722322776917, 27867.442651146863, 28004.0, 28063.719362806518, 7537.2462753724185, 7676.078870535572, 7734.651940662571, 7792.883106753403, 7850.057993040871, 3926.2343842950922, 3965.8017099144927, 3986.740861843971, 4013.418054382098, 4024.0342317843506, 5000.299958005882, 5034.949650503521, 5117.8464646060675, 5153.5361817436615, 5177.456367081402, 892.4199270474114, 921.5069937583361, 923.6443969071821, 926.8100039491889, 929.1126973740062, 670.5004771445305, 674.3829396102511, 677.7831094049857, 691.2948792231896, 717.2397258905472, 11099.556017759362, 11353.659390218307, 11445.828312575319, 11459.656210313704, 11581.594644187413, 626.9780557680459, 626.9811905642838, 650.1028580558799, 652.3085529338916, 661.5832025823701, 4921.704697718148, 5126.948730512647, 5196.610254230948, 5202.193659982709, 5231.764570594332, 98768.50615746876, 102761.0, 104285.47857260665, 105303.0, 106184.0, 91471.54264228769, 91652.0, 93345.0, 94299.0, 96151.0384896156, 80055.19944800477, 80634.19365806384, 82858.15592211371, 83724.58137709272, 84237.0, 10106.49467526606, 10131.696049118538, 10195.898041019494, 10355.068043876086, 11010.779784404107, 35609.08300086937, 36804.26391472102, 37356.06609834776, 37484.81257593694, 38978.6102138975, 64046.35953640404, 65774.34225657683, 66987.0, 67542.66228668825, 71198.64400677964, 18459.0, 18469.53826154357, 18613.348532801287, 18771.34300299483, 18926.3375781847, 19442.542217300805, 19652.803471965097, 20487.4878128048, 20674.896625517376, 21161.6825747617, 17330.74003889968, 17722.5569360767, 17814.0, 18038.729419058986, 18104.547386315448, 18791.90604046971, 19020.809791901906, 19253.90373048126, 19274.8072519273, 19593.902030489757, 17105.914470427568, 17713.645727085644, 17732.0247386395, 18033.639327213645, 18069.548261293574, 11912.880871191177, 12409.0, 12518.248905065726, 12534.498620055096, 12573.93713031429, 12428.502859885502, 12741.17182383142, 13110.803337949748, 13616.523421680193, 14216.786748198992], "value": 8803.002399788404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 108.0, 108.0, 108.0, 110.0, 108.0, 109.0, 109.0, 112.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 147.0, 180.0, 122.0, 151.0, 146.0, 126.0, 184.0, 122.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 162.0, 167.0, 162.0, 161.0, 171.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 169.0, 77.0, 73.0, 76.0, 76.0, 100.0, 75.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 131.0, 80.0, 82.0, 80.0, 134.0, 82.0, 81.0, 131.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 152.0, 149.0, 150.0, 155.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 59.0, 54.0, 63.0, 62.0, 57.0, 54.0, 55.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 86.0, 78.0, 87.0, 77.0, 77.0, 77.0, 86.0, 77.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 125.0, 136.0, 128.0, 137.0, 130.0, 125.0, 126.0, 159.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 189.0, 186.0, 187.0, 185.0, 185.0, 182.0, 182.0, 189.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 79.0, 68.0, 73.0, 72.0, 70.0, 69.0, 72.0, 69.0], "value": 71.5, "unit": "score"}]}]} 06:08:49 INFO - Return code: 0 06:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:49 INFO - # TBPL SUCCESS # 06:08:49 INFO - Running post-action listener: _package_coverage_data 06:08:49 INFO - Running post-action listener: _resource_record_post_action 06:08:49 INFO - [mozharness: 2017-07-17 13:08:49.421668Z] Finished run-tests step (success) 06:08:49 INFO - Running post-run listener: _resource_record_post_run 06:08:49 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 86016; Write bytes: 434634752; Read time: 124; Write time: 340508 06:08:49 INFO - TinderboxPrint: CPU usage
13.1% 06:08:49 INFO - TinderboxPrint: I/O read bytes / time
86,016 / 124 06:08:49 INFO - TinderboxPrint: I/O write bytes / time
434,634,752 / 340,508 06:08:49 INFO - TinderboxPrint: CPU idle
8,252.3 (86.9%) 06:08:49 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 06:08:49 INFO - TinderboxPrint: Swap in / out
0 / 0 06:08:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106799104; Read time: 28; Write time: 90772 06:08:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:08:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 77824; Write bytes: 325091328; Read time: 64; Write time: 249396 06:08:50 INFO - Running post-run listener: _upload_blobber_files 06:08:50 INFO - Blob upload gear active. 06:08:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08: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 06:08: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'] 06:08: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 06:08:50 INFO - Traceback (most recent call last): 06:08:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 06:08:50 INFO - main() 06:08:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 06:08:50 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 06:08:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 06:08:50 INFO - return set(response.json().get('whitelist', [])) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 06:08:50 INFO - return json.loads(self.text or self.content, **kwargs) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 06:08:50 INFO - return _default_decoder.decode(s) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 06:08:50 INFO - obj, end = self.raw_decode(s) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 06:08:50 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 06:08:50 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 06:08:50 ERROR - Return code: 1 06:08:50 INFO - Setting buildbot property blobber_files to {} 06:08:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:50 INFO - Contents: 06:08:50 INFO - blobber_files:{} 06:08:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:50 INFO - Copying logs to upload dir... 06:08:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.015664 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-17 06:08:50.565904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:50.573876) ========= 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=7de08804244eb36560b44971000001c3-1500288307.299593-304713271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:50.603482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:50.603839) ========= 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=7de08804244eb36560b44971000001c3-1500288307.299593-304713271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:50.655464) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:08:50.655778) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:08:50.656068) ========= ========= Total master_lag: 0.37 =========