builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1503338303.71 results: success (0) revision: a9d372645a32b8d23d44244f351639af9d73b96a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.708253) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.708730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.709025) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.745839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.746108) ========= 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=31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 10:58:23-- 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% 46.2M=0s 2017-08-21 10:58:23 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116802 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.892844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.893184) ========= 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=31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021196 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.943689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.944044) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a9d372645a32b8d23d44244f351639af9d73b96a --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 a9d372645a32b8d23d44244f351639af9d73b96a --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=31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 10:58:23,975 truncating revision to first 12 chars 2017-08-21 10:58:23,975 Setting DEBUG logging. 2017-08-21 10:58:23,975 attempt 1/10 2017-08-21 10:58:23,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a9d372645a32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 10:58:24,310 unpacking tar archive at: mozilla-central-a9d372645a32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682708 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.644030) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.644473) ========= script_repo_revision: a9d372645a32b8d23d44244f351639af9d73b96a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.644920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.645267) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.658212) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-21 10:58:24.658485) ========= /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=31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:24 INFO - MultiFileLogger online at 20170821 10:58:24 in /builds/slave/test 10:58:24 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 10:58:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:24 INFO - {'append_to_log': False, 10:58:24 INFO - 'base_work_dir': '/builds/slave/test', 10:58:24 INFO - 'blob_upload_branch': 'Firefox', 10:58:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:24 INFO - 'branch': 'Firefox', 10:58:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:24 INFO - 'code_coverage': False, 10:58:24 INFO - 'config_files': ('talos/linux_config.py',), 10:58:24 INFO - 'default_actions': ('clobber', 10:58:24 INFO - 'read-buildbot-config', 10:58:24 INFO - 'download-and-extract', 10:58:24 INFO - 'populate-webroot', 10:58:24 INFO - 'create-virtualenv', 10:58:24 INFO - 'install', 10:58:24 INFO - 'setup-mitmproxy', 10:58:24 INFO - 'run-tests'), 10:58:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:24 INFO - 'disable_ccov_upload': False, 10:58:24 INFO - 'download_minidump_stackwalk': True, 10:58:24 INFO - 'download_symbols': 'ondemand', 10:58:24 INFO - 'enable_stylo': False, 10:58:24 INFO - 'enable_webrender': False, 10:58:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:24 INFO - 'gecko_profile': False, 10:58:24 INFO - 'gecko_profile_interval': 0, 10:58:24 INFO - 'installer_path': 'installer.exe', 10:58:24 INFO - 'log_level': 'info', 10:58:24 INFO - 'log_name': 'talos', 10:58:24 INFO - 'log_to_console': True, 10:58:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:24 INFO - 'opt_config_files': (), 10:58:24 INFO - 'pip_index': False, 10:58:24 INFO - 'suite': 'dromaeojs-e10s', 10:58:24 INFO - 'system_bits': '32', 10:58:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:24 INFO - 'title': 'talos-linux64-ix-014', 10:58:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:24 INFO - 'use_talos_json': True, 10:58:24 INFO - 'verify': 'False', 10:58:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:24 INFO - 'work_dir': 'build'} 10:58:24 INFO - [mozharness: 2017-08-21 17:58:24.908916Z] Running clobber step. 10:58:24 INFO - Running pre-action listener: _resource_record_pre_action 10:58:24 INFO - Running main action method: clobber 10:58:24 INFO - rmtree: /builds/slave/test/build 10:58:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:25 INFO - Running post-action listener: _resource_record_post_action 10:58:25 INFO - [mozharness: 2017-08-21 17:58:25.899644Z] Finished clobber step (success) 10:58:25 INFO - [mozharness: 2017-08-21 17:58:25.899741Z] Running read-buildbot-config step. 10:58:25 INFO - Running pre-action listener: _resource_record_pre_action 10:58:25 INFO - Running main action method: read_buildbot_config 10:58:25 INFO - Using buildbot properties: 10:58:25 INFO - { 10:58:25 INFO - "project": "", 10:58:25 INFO - "product": "firefox", 10:58:25 INFO - "who": "ffxbld@noreply.mozilla.org", 10:58:25 INFO - "installer_path": "public/build/target.tar.bz2", 10:58:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:58:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:58:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:58:25 INFO - "stage_platform": "linux64-stylo", 10:58:25 INFO - "basedir": "/builds/slave/test", 10:58:25 INFO - "buildnumber": 277, 10:58:25 INFO - "platform": "ubuntu64_hw_stylo", 10:58:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:58:25 INFO - "slavebuilddir": "test", 10:58:25 INFO - "taskId": "EtRZaMEPT0CXTdsc8nL_aA", 10:58:25 INFO - "branch": "mozilla-central", 10:58:25 INFO - "script_repo_revision": "production", 10:58:25 INFO - "revision": "a9d372645a32b8d23d44244f351639af9d73b96a", 10:58:25 INFO - "slavename": "talos-linux64-ix-014", 10:58:25 INFO - "repo_path": "mozilla-central" 10:58:25 INFO - } 10:58:25 INFO - Finding installer, test and symbols from parent task. 10:58:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EtRZaMEPT0CXTdsc8nL_aA'}, attempt #1 10:58:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EtRZaMEPT0CXTdsc8nL_aA'}, attempt #1 10:58:26 INFO - Task dependencies: MLlCFHQhSUSWzn2nnk1GfQ 10:58:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ'}, attempt #1 10:58:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:58:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json 10:58:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip 10:58:27 INFO - Running post-action listener: _resource_record_post_action 10:58:27 INFO - [mozharness: 2017-08-21 17:58:27.250034Z] Finished read-buildbot-config step (success) 10:58:27 INFO - [mozharness: 2017-08-21 17:58:27.250250Z] Running download-and-extract step. 10:58:27 INFO - Running pre-action listener: _resource_record_pre_action 10:58:27 INFO - Running main action method: download_and_extract 10:58:27 INFO - mkdir: /builds/slave/test/build/tests 10:58:27 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')]} 10:58:27 INFO - trying https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json 10:58:27 INFO - Downloading https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:58:27 INFO - Downloaded 989 bytes. 10:58:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:58:27 INFO - Using the following test package requirements: 10:58:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:58:27 INFO - u'common': [u'target.common.tests.zip'], 10:58:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:58:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:58:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:58:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:58:27 INFO - u'mozbase': [u'target.common.tests.zip'], 10:58:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:58:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:58:27 INFO - u'web-platform': [u'target.common.tests.zip', 10:58:27 INFO - u'target.web-platform.tests.tar.gz'], 10:58:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:58:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:58:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip 10:58:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:27 INFO - Fetch https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip into memory 10:58:30 INFO - Content-Length response header: 54005943 10:58:30 INFO - Bytes received: 54005943 10:58:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:58:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip 10:58:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:41 INFO - Fetch https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip into memory 10:58:44 INFO - Content-Length response header: 54005943 10:58:44 INFO - Bytes received: 54005943 10:58:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.talos.tests.zip 10:58:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:58:57 INFO - Fetch https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.talos.tests.zip into memory 10:58:58 INFO - Content-Length response header: 14496256 10:58:58 INFO - Bytes received: 14496256 10:58:58 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')]} 10:58:58 INFO - trying https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:58:58 INFO - Downloading https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:59:01 INFO - Downloaded 62023543 bytes. 10:59:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:59:01 INFO - mkdir: /builds/slave/test/properties 10:59:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:01 INFO - Contents: 10:59:01 INFO - build_url:https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:59:01 INFO - Running post-action listener: _resource_record_post_action 10:59:01 INFO - Running post-action listener: find_tests_for_verification 10:59:01 INFO - Running post-action listener: set_extra_try_arguments 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.332788Z] Finished download-and-extract step (success) 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.333016Z] Running populate-webroot step. 10:59:01 INFO - Running pre-action listener: _resource_record_pre_action 10:59:01 INFO - Running main action method: populate_webroot 10:59:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:59:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'tests': ['damp', 'tps']}, 10:59:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['damp', 'tps']}, 10:59:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:59:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:59:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:59:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:59:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:01 INFO - 'ts_paint', 10:59:01 INFO - 'tpaint', 10:59:01 INFO - 'sessionrestore', 10:59:01 INFO - 'sessionrestore_many_windows', 10:59:01 INFO - 'sessionrestore_no_auto_restore', 10:59:01 INFO - 'tabpaint']}, 10:59:01 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['a11yr', 10:59:01 INFO - 'ts_paint', 10:59:01 INFO - 'tpaint', 10:59:01 INFO - 'sessionrestore', 10:59:01 INFO - 'sessionrestore_many_windows', 10:59:01 INFO - 'sessionrestore_no_auto_restore', 10:59:01 INFO - 'tabpaint']}, 10:59:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:59:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:59:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['bloom_basic_singleton']}, 10:59:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['bloom_basic']}, 10:59:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:01 INFO - 'tsvgr_opacity', 10:59:01 INFO - 'tart', 10:59:01 INFO - 'tscrollx', 10:59:01 INFO - 'tsvg_static']}, 10:59:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tsvgx', 10:59:01 INFO - 'tsvgr_opacity', 10:59:01 INFO - 'tart', 10:59:01 INFO - 'tscrollx', 10:59:01 INFO - 'tsvg_static']}, 10:59:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:59:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tp5o']}, 10:59:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:01 INFO - 'talos_options': ['--mitmproxy', 10:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:01 INFO - '--firstNonBlankPaint'], 10:59:01 INFO - 'tests': ['tp6_google', 10:59:01 INFO - 'tp6_youtube', 10:59:01 INFO - 'tp6_amazon', 10:59:01 INFO - 'tp6_facebook']}, 10:59:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:01 INFO - 'talos_options': ['--stylo', 10:59:01 INFO - '--mitmproxy', 10:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:01 INFO - '--firstNonBlankPaint'], 10:59:01 INFO - 'tests': ['tp6_google', 10:59:01 INFO - 'tp6_youtube', 10:59:01 INFO - 'tp6_amazon', 10:59:01 INFO - 'tp6_facebook']}, 10:59:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:01 INFO - 'talos_options': ['--stylo', 10:59:01 INFO - '--stylo-threads=1', 10:59:01 INFO - '--mitmproxy', 10:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:01 INFO - '--firstNonBlankPaint'], 10:59:01 INFO - 'tests': ['tp6_google', 10:59:01 INFO - 'tp6_youtube', 10:59:01 INFO - 'tp6_amazon', 10:59:01 INFO - 'tp6_facebook']}, 10:59:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--xperf_path', 10:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:01 INFO - 'tests': ['tp5n']}, 10:59:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo', 10:59:01 INFO - '--xperf_path', 10:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:01 INFO - 'tests': ['tp5n']}}} 10:59:01 INFO - Running post-action listener: _resource_record_post_action 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.354736Z] Finished populate-webroot step (success) 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.354824Z] Running create-virtualenv step. 10:59:01 INFO - Running pre-action listener: _resource_record_pre_action 10:59:01 INFO - Running main action method: create_virtualenv 10:59:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:01 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 10:59:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:59:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:01 INFO - Using real prefix '/usr' 10:59:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:03 INFO - Installing pip.................done. 10:59:04 INFO - Return code: 0 10:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:59:04 INFO - Reading from file tmpfile_stdout 10:59:04 INFO - Output received: 10:59:04 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) 10:59:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:04 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:04 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 10:59:04 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 10:59:04 INFO - Using env: {'DISPLAY': ':0', 10:59:04 INFO - 'HOME': '/home/cltbld', 10:59:04 INFO - 'LANG': 'en_US.UTF-8', 10:59:04 INFO - 'LANGUAGE': 'en_US:en', 10:59:04 INFO - 'LOGNAME': 'cltbld', 10:59:04 INFO - 'MAIL': '/var/mail/cltbld', 10:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:04 INFO - 'MOZ_NO_REMOTE': '1', 10:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:04 INFO - 'NO_EM_RESTART': '1', 10:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:04 INFO - 'PWD': '/builds/slave/test', 10:59:04 INFO - 'SHELL': '/bin/bash', 10:59:04 INFO - 'SHLVL': '1', 10:59:04 INFO - 'TERM': 'linux', 10:59:04 INFO - 'TMOUT': '86400', 10:59:04 INFO - 'USER': 'cltbld', 10:59:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:04 INFO - '_': '/tools/buildbot/bin/python'} 10:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:04 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 10:59:04 INFO - Cleaning up... 10:59:04 INFO - Return code: 0 10:59:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:04 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:04 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 10:59:04 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 10:59:04 INFO - Using env: {'DISPLAY': ':0', 10:59:04 INFO - 'HOME': '/home/cltbld', 10:59:04 INFO - 'LANG': 'en_US.UTF-8', 10:59:04 INFO - 'LANGUAGE': 'en_US:en', 10:59:04 INFO - 'LOGNAME': 'cltbld', 10:59:04 INFO - 'MAIL': '/var/mail/cltbld', 10:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:04 INFO - 'MOZ_NO_REMOTE': '1', 10:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:04 INFO - 'NO_EM_RESTART': '1', 10:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:04 INFO - 'PWD': '/builds/slave/test', 10:59:04 INFO - 'SHELL': '/bin/bash', 10:59:04 INFO - 'SHLVL': '1', 10:59:04 INFO - 'TERM': 'linux', 10:59:04 INFO - 'TMOUT': '86400', 10:59:04 INFO - 'USER': 'cltbld', 10:59:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:04 INFO - '_': '/tools/buildbot/bin/python'} 10:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:04 INFO - Downloading/unpacking psutil>=3.1.1 10:59:04 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 10:59:04 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 10:59:04 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 10:59:04 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 10:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:06 INFO - Installing collected packages: psutil 10:59:06 INFO - Running setup.py install for psutil 10:59:06 INFO - building 'psutil._psutil_linux' extension 10:59:06 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 10:59:06 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 10:59:07 INFO - building 'psutil._psutil_posix' extension 10:59:07 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 10:59:07 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 10:59:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:07 INFO - Successfully installed psutil 10:59:07 INFO - Cleaning up... 10:59:07 INFO - Return code: 0 10:59:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:59:07 INFO - Using env: {'DISPLAY': ':0', 10:59:07 INFO - 'HOME': '/home/cltbld', 10:59:07 INFO - 'LANG': 'en_US.UTF-8', 10:59:07 INFO - 'LANGUAGE': 'en_US:en', 10:59:07 INFO - 'LOGNAME': 'cltbld', 10:59:07 INFO - 'MAIL': '/var/mail/cltbld', 10:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:07 INFO - 'MOZ_NO_REMOTE': '1', 10:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:07 INFO - 'NO_EM_RESTART': '1', 10:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:07 INFO - 'PWD': '/builds/slave/test', 10:59:07 INFO - 'SHELL': '/bin/bash', 10:59:07 INFO - 'SHLVL': '1', 10:59:07 INFO - 'TERM': 'linux', 10:59:07 INFO - 'TMOUT': '86400', 10:59:07 INFO - 'USER': 'cltbld', 10:59:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:07 INFO - '_': '/tools/buildbot/bin/python'} 10:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:07 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 10:59:07 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 10:59:07 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 10:59:07 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 10:59:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:08 INFO - Installing collected packages: mozsystemmonitor 10:59:08 INFO - Running setup.py install for mozsystemmonitor 10:59:08 INFO - Successfully installed mozsystemmonitor 10:59:08 INFO - Cleaning up... 10:59:08 INFO - Return code: 0 10:59:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:08 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:08 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 10:59:08 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 10:59:08 INFO - Using env: {'DISPLAY': ':0', 10:59:08 INFO - 'HOME': '/home/cltbld', 10:59:08 INFO - 'LANG': 'en_US.UTF-8', 10:59:08 INFO - 'LANGUAGE': 'en_US:en', 10:59:08 INFO - 'LOGNAME': 'cltbld', 10:59:08 INFO - 'MAIL': '/var/mail/cltbld', 10:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:08 INFO - 'MOZ_NO_REMOTE': '1', 10:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:08 INFO - 'NO_EM_RESTART': '1', 10:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:08 INFO - 'PWD': '/builds/slave/test', 10:59:08 INFO - 'SHELL': '/bin/bash', 10:59:08 INFO - 'SHLVL': '1', 10:59:08 INFO - 'TERM': 'linux', 10:59:08 INFO - 'TMOUT': '86400', 10:59:08 INFO - 'USER': 'cltbld', 10:59:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:08 INFO - '_': '/tools/buildbot/bin/python'} 10:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:09 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:09 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 10:59:09 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 10:59:09 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 10:59:09 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 10:59:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:10 INFO - warning: no files found matching '*.txt' 10:59:10 INFO - no previously-included directories found matching 'build' 10:59:10 INFO - no previously-included directories found matching 'dist' 10:59:10 INFO - no previously-included directories found matching '.git*' 10:59:10 INFO - Installing collected packages: jsonschema, functools32 10:59:10 INFO - Running setup.py install for functools32 10:59:10 INFO - warning: no files found matching '*.txt' 10:59:10 INFO - no previously-included directories found matching 'build' 10:59:10 INFO - no previously-included directories found matching 'dist' 10:59:10 INFO - no previously-included directories found matching '.git*' 10:59:10 INFO - Successfully installed jsonschema functools32 10:59:10 INFO - Cleaning up... 10:59:10 INFO - Return code: 0 10:59:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:10 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:10 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 10:59:10 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 10:59:10 INFO - Using env: {'DISPLAY': ':0', 10:59:10 INFO - 'HOME': '/home/cltbld', 10:59:10 INFO - 'LANG': 'en_US.UTF-8', 10:59:10 INFO - 'LANGUAGE': 'en_US:en', 10:59:10 INFO - 'LOGNAME': 'cltbld', 10:59:10 INFO - 'MAIL': '/var/mail/cltbld', 10:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:10 INFO - 'MOZ_NO_REMOTE': '1', 10:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:10 INFO - 'NO_EM_RESTART': '1', 10:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:10 INFO - 'PWD': '/builds/slave/test', 10:59:10 INFO - 'SHELL': '/bin/bash', 10:59:10 INFO - 'SHLVL': '1', 10:59:10 INFO - 'TERM': 'linux', 10:59:10 INFO - 'TMOUT': '86400', 10:59:10 INFO - 'USER': 'cltbld', 10:59:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:10 INFO - '_': '/tools/buildbot/bin/python'} 10:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:10 INFO - Cleaning up... 10:59:10 INFO - Return code: 0 10:59:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:10 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:10 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 10:59:10 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 10:59:10 INFO - Using env: {'DISPLAY': ':0', 10:59:10 INFO - 'HOME': '/home/cltbld', 10:59:10 INFO - 'LANG': 'en_US.UTF-8', 10:59:10 INFO - 'LANGUAGE': 'en_US:en', 10:59:10 INFO - 'LOGNAME': 'cltbld', 10:59:10 INFO - 'MAIL': '/var/mail/cltbld', 10:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:10 INFO - 'MOZ_NO_REMOTE': '1', 10:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:10 INFO - 'NO_EM_RESTART': '1', 10:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:10 INFO - 'PWD': '/builds/slave/test', 10:59:10 INFO - 'SHELL': '/bin/bash', 10:59:10 INFO - 'SHLVL': '1', 10:59:10 INFO - 'TERM': 'linux', 10:59:10 INFO - 'TMOUT': '86400', 10:59:10 INFO - 'USER': 'cltbld', 10:59:10 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:10 INFO - '_': '/tools/buildbot/bin/python'} 10:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 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 10:59:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:12 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 10:59:12 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 10:59:12 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 10:59:12 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 10:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:12 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 10:59:12 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 10:59:12 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 10:59:12 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 10:59:12 INFO - Downloading docopt-0.6.1.tar.gz 10:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:12 INFO - Running setup.py install for blobuploader 10:59:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:12 INFO - Running setup.py install for requests 10:59:13 INFO - Running setup.py install for docopt 10:59:13 INFO - Successfully installed blobuploader requests docopt 10:59:13 INFO - Cleaning up... 10:59:13 INFO - Return code: 0 10:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:13 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')]} 10:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:13 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')]} 10:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:13 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:13 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 10:59:13 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 10:59:13 INFO - Using env: {'DISPLAY': ':0', 10:59:13 INFO - 'HOME': '/home/cltbld', 10:59:13 INFO - 'LANG': 'en_US.UTF-8', 10:59:13 INFO - 'LANGUAGE': 'en_US:en', 10:59:13 INFO - 'LOGNAME': 'cltbld', 10:59:13 INFO - 'MAIL': '/var/mail/cltbld', 10:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:13 INFO - 'MOZ_NO_REMOTE': '1', 10:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:13 INFO - 'NO_EM_RESTART': '1', 10:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:13 INFO - 'PWD': '/builds/slave/test', 10:59:13 INFO - 'SHELL': '/bin/bash', 10:59:13 INFO - 'SHLVL': '1', 10:59:13 INFO - 'TERM': 'linux', 10:59:13 INFO - 'TMOUT': '86400', 10:59:13 INFO - 'USER': 'cltbld', 10:59:13 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:13 INFO - '_': '/tools/buildbot/bin/python'} 10:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:13 INFO - Running setup.py (path:/tmp/pip-k7sO4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:13 INFO - Running setup.py (path:/tmp/pip-IPsUFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:13 INFO - Running setup.py (path:/tmp/pip-Gvomzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:13 INFO - Running setup.py (path:/tmp/pip-1oBjA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:13 INFO - Running setup.py (path:/tmp/pip-EXQTpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:13 INFO - Running setup.py (path:/tmp/pip-QuIOoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:13 INFO - Running setup.py (path:/tmp/pip-a1T2eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:13 INFO - Running setup.py (path:/tmp/pip-1FnLLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:14 INFO - Running setup.py (path:/tmp/pip-qWR_ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:14 INFO - Running setup.py (path:/tmp/pip-Xciua9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:14 INFO - Running setup.py (path:/tmp/pip-xLG7VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:14 INFO - Running setup.py (path:/tmp/pip-8qbbhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:14 INFO - Running setup.py (path:/tmp/pip-Bsoynh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:14 INFO - Running setup.py (path:/tmp/pip-os1LU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:14 INFO - Running setup.py (path:/tmp/pip-LnOJEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:14 INFO - Running setup.py (path:/tmp/pip-LQhHhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:14 INFO - Running setup.py (path:/tmp/pip-c2aDkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:14 INFO - Running setup.py install for manifestparser 10:59:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:14 INFO - Running setup.py install for mozcrash 10:59:14 INFO - Running setup.py install for mozdebug 10:59:14 INFO - Running setup.py install for mozdevice 10:59:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozfile 10:59:15 INFO - Running setup.py install for mozhttpd 10:59:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozinfo 10:59:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozInstall 10:59:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozleak 10:59:15 INFO - Running setup.py install for mozlog 10:59:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for moznetwork 10:59:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozprocess 10:59:15 INFO - Running setup.py install for mozprofile 10:59:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:16 INFO - Running setup.py install for mozrunner 10:59:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:16 INFO - Running setup.py install for mozscreenshot 10:59:16 INFO - Running setup.py install for moztest 10:59:16 INFO - Running setup.py install for mozversion 10:59:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:16 INFO - Cleaning up... 10:59:16 INFO - Return code: 0 10:59:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:16 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:16 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 10:59:16 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 10:59:16 INFO - Using env: {'DISPLAY': ':0', 10:59:16 INFO - 'HOME': '/home/cltbld', 10:59:16 INFO - 'LANG': 'en_US.UTF-8', 10:59:16 INFO - 'LANGUAGE': 'en_US:en', 10:59:16 INFO - 'LOGNAME': 'cltbld', 10:59:16 INFO - 'MAIL': '/var/mail/cltbld', 10:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:16 INFO - 'MOZ_NO_REMOTE': '1', 10:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:16 INFO - 'NO_EM_RESTART': '1', 10:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:16 INFO - 'PWD': '/builds/slave/test', 10:59:16 INFO - 'SHELL': '/bin/bash', 10:59:16 INFO - 'SHLVL': '1', 10:59:16 INFO - 'TERM': 'linux', 10:59:16 INFO - 'TMOUT': '86400', 10:59:16 INFO - 'USER': 'cltbld', 10:59:16 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:16 INFO - '_': '/tools/buildbot/bin/python'} 10:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:16 INFO - Running setup.py (path:/tmp/pip-SvEfAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:16 INFO - Running setup.py (path:/tmp/pip-5diMdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:16 INFO - Running setup.py (path:/tmp/pip-eP0kP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:16 INFO - Running setup.py (path:/tmp/pip-tP4Xr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:17 INFO - Running setup.py (path:/tmp/pip-NZyG5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:17 INFO - Running setup.py (path:/tmp/pip-5xQvuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:17 INFO - Running setup.py (path:/tmp/pip-w0T36X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:17 INFO - Running setup.py (path:/tmp/pip-Mg5Iil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:17 INFO - Running setup.py (path:/tmp/pip-MBrlDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:17 INFO - Running setup.py (path:/tmp/pip-ZNrOqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:17 INFO - Running setup.py (path:/tmp/pip-Q8jRu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:17 INFO - Running setup.py (path:/tmp/pip-A2YE9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:17 INFO - Running setup.py (path:/tmp/pip-4fFanE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:17 INFO - Running setup.py (path:/tmp/pip-rMrnPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:17 INFO - Running setup.py (path:/tmp/pip-Xfo_iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:17 INFO - Running setup.py (path:/tmp/pip-0zRzNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:17 INFO - Running setup.py (path:/tmp/pip-KxA1Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:17 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 10:59:17 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 10:59:17 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 10:59:17 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 10:59:19 INFO - Downloading blessings-1.6.tar.gz 10:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:19 INFO - Installing collected packages: blessings 10:59:19 INFO - Running setup.py install for blessings 10:59:19 INFO - Successfully installed blessings 10:59:19 INFO - Cleaning up... 10:59:19 INFO - Return code: 0 10:59:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:19 INFO - Reading from file tmpfile_stdout 10:59:19 INFO - Current package versions: 10:59:19 INFO - argparse == 1.2.1 10:59:19 INFO - blessings == 1.6 10:59:19 INFO - blobuploader == 1.2.4 10:59:19 INFO - docopt == 0.6.1 10:59:19 INFO - functools32 == 3.2.3-2 10:59:19 INFO - jsonschema == 2.5.1 10:59:19 INFO - manifestparser == 1.1 10:59:19 INFO - mozInstall == 1.13 10:59:19 INFO - mozcrash == 1.0 10:59:19 INFO - mozdebug == 0.1 10:59:19 INFO - mozdevice == 0.51 10:59:19 INFO - mozfile == 1.2 10:59:19 INFO - mozhttpd == 0.7 10:59:19 INFO - mozinfo == 0.10 10:59:19 INFO - mozleak == 0.1 10:59:19 INFO - mozlog == 3.5 10:59:19 INFO - moznetwork == 0.27 10:59:19 INFO - mozprocess == 0.25 10:59:19 INFO - mozprofile == 0.28 10:59:19 INFO - mozrunner == 6.13 10:59:19 INFO - mozscreenshot == 0.1 10:59:19 INFO - mozsystemmonitor == 0.3 10:59:19 INFO - moztest == 0.8 10:59:19 INFO - mozversion == 1.4 10:59:19 INFO - psutil == 3.1.1 10:59:19 INFO - requests == 1.2.3 10:59:19 INFO - wsgiref == 0.1.2 10:59:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:19 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')]} 10:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:19 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')]} 10:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:19 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:19 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 10:59:19 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 10:59:19 INFO - Using env: {'DISPLAY': ':0', 10:59:19 INFO - 'HOME': '/home/cltbld', 10:59:19 INFO - 'LANG': 'en_US.UTF-8', 10:59:19 INFO - 'LANGUAGE': 'en_US:en', 10:59:19 INFO - 'LOGNAME': 'cltbld', 10:59:19 INFO - 'MAIL': '/var/mail/cltbld', 10:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:19 INFO - 'MOZ_NO_REMOTE': '1', 10:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:19 INFO - 'NO_EM_RESTART': '1', 10:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:19 INFO - 'PWD': '/builds/slave/test', 10:59:19 INFO - 'SHELL': '/bin/bash', 10:59:19 INFO - 'SHLVL': '1', 10:59:19 INFO - 'TERM': 'linux', 10:59:19 INFO - 'TMOUT': '86400', 10:59:19 INFO - 'USER': 'cltbld', 10:59:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:19 INFO - '_': '/tools/buildbot/bin/python'} 10:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:59:19 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 10:59:19 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 10:59:19 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 10:59:19 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 10:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:59:20 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)) 10:59:20 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)) 10:59:20 INFO - Installing collected packages: simplejson 10:59:20 INFO - Running setup.py install for simplejson 10:59:21 INFO - building 'simplejson._speedups' extension 10:59:21 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 10:59:21 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 10:59:21 INFO - Successfully installed simplejson 10:59:21 INFO - Cleaning up... 10:59:22 INFO - Return code: 0 10:59:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59:22 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')]} 10:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:22 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')]} 10:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:22 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 0xeef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x125df90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, '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': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', '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 10:59:22 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 10:59:22 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 10:59:22 INFO - Using env: {'DISPLAY': ':0', 10:59:22 INFO - 'HOME': '/home/cltbld', 10:59:22 INFO - 'LANG': 'en_US.UTF-8', 10:59:22 INFO - 'LANGUAGE': 'en_US:en', 10:59:22 INFO - 'LOGNAME': 'cltbld', 10:59:22 INFO - 'MAIL': '/var/mail/cltbld', 10:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:22 INFO - 'MOZ_NO_REMOTE': '1', 10:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:22 INFO - 'NO_EM_RESTART': '1', 10:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:22 INFO - 'PWD': '/builds/slave/test', 10:59:22 INFO - 'SHELL': '/bin/bash', 10:59:22 INFO - 'SHLVL': '1', 10:59:22 INFO - 'TERM': 'linux', 10:59:22 INFO - 'TMOUT': '86400', 10:59:22 INFO - 'USER': 'cltbld', 10:59:22 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:22 INFO - '_': '/tools/buildbot/bin/python'} 10:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:22 INFO - Cleaning up... 10:59:22 INFO - Return code: 0 10:59:22 INFO - Running post-action listener: _resource_record_post_action 10:59:22 INFO - Running post-action listener: _start_resource_monitoring 10:59:22 INFO - Starting resource monitoring. 10:59:22 INFO - [mozharness: 2017-08-21 17:59:22.276074Z] Finished create-virtualenv step (success) 10:59:22 INFO - [mozharness: 2017-08-21 17:59:22.277115Z] Running install step. 10:59:22 INFO - Running pre-action listener: _resource_record_pre_action 10:59:22 INFO - Running main action method: install 10:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:22 INFO - Reading from file tmpfile_stdout 10:59:22 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:22 INFO - Reading from file tmpfile_stdout 10:59:22 INFO - Output received: 10:59:22 INFO - Usage: mozinstall [options] installer 10:59:22 INFO - Options: 10:59:22 INFO - -h, --help show this help message and exit 10:59:22 INFO - -d DEST, --destination=DEST 10:59:22 INFO - Directory to install application into. [default: 10:59:22 INFO - "/builds/slave/test"] 10:59:22 INFO - --app=APP Application being installed. [default: firefox] 10:59:22 INFO - mkdir: /builds/slave/test/build/application 10:59:22 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'] 10:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:59:40 INFO - Reading from file tmpfile_stdout 10:59:40 INFO - Output received: 10:59:40 INFO - /builds/slave/test/build/application/firefox/firefox 10:59:40 INFO - Running post-action listener: _resource_record_post_action 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.630485Z] Finished install step (success) 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.630764Z] Running setup-mitmproxy step. 10:59:40 INFO - Running pre-action listener: _resource_record_pre_action 10:59:40 INFO - Running main action method: setup_mitmproxy 10:59:40 INFO - Skipping: mitmproxy is not required 10:59:40 INFO - Running post-action listener: _resource_record_post_action 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.631902Z] Finished setup-mitmproxy step (success) 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.632119Z] Running run-tests step. 10:59:40 INFO - Running pre-action listener: _resource_record_pre_action 10:59:40 INFO - Running pre-action listener: _set_gcov_prefix 10:59:40 INFO - Running main action method: run_tests 10:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:59:40 INFO - Python 2.7.3 10:59:40 INFO - Return code: 0 10:59:40 INFO - grabbing minidump binary from tooltool 10:59: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')]} 10:59:40 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 0x125b130>, '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 0x125c030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125c4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:59:40 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 10:59:40 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 10:59:40 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 10:59:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:41 INFO - Return code: 0 10:59:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:59:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:59:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:59:41 INFO - ENV: RUST_BACKTRACE is now full 10:59:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:59:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:59:41 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/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:59:41 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/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 10:59:41 INFO - Using env: {'DISPLAY': ':0', 10:59:41 INFO - 'HOME': '/home/cltbld', 10:59:41 INFO - 'LANG': 'en_US.UTF-8', 10:59:41 INFO - 'LANGUAGE': 'en_US:en', 10:59:41 INFO - 'LOGNAME': 'cltbld', 10:59:41 INFO - 'MAIL': '/var/mail/cltbld', 10:59:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:41 INFO - 'MOZ_NO_REMOTE': '1', 10:59:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:41 INFO - 'NO_EM_RESTART': '1', 10:59:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:41 INFO - 'PWD': '/builds/slave/test', 10:59:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:41 INFO - 'RUST_BACKTRACE': 'full', 10:59:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:59:41 INFO - 'SHELL': '/bin/bash', 10:59:41 INFO - 'SHLVL': '1', 10:59:41 INFO - 'STYLO_FORCE_ENABLED': '1', 10:59:41 INFO - 'TERM': 'linux', 10:59:41 INFO - 'TMOUT': '86400', 10:59:41 INFO - 'USER': 'cltbld', 10:59:41 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468', 10:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:41 INFO - '_': '/tools/buildbot/bin/python'} 10:59:41 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/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:59:41 INFO - mozversion application_buildid: 20170821171611 10:59:41 INFO - mozversion application_changeset: a9d372645a32b8d23d44244f351639af9d73b96a 10:59:41 INFO - mozversion application_display_name: Nightly 10:59:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:41 INFO - mozversion application_name: Firefox 10:59:41 INFO - mozversion application_remotingname: firefox 10:59:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:59:41 INFO - mozversion application_vendor: Mozilla 10:59:41 INFO - mozversion application_version: 57.0a1 10:59:41 INFO - mozversion platform_buildid: 20170821171611 10:59:41 INFO - mozversion platform_changeset: a9d372645a32b8d23d44244f351639af9d73b96a 10:59:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:59:41 INFO - mozversion platform_version: 57.0a1 10:59:41 INFO - using testdate: 1503338381 10:59:41 INFO - actual date: 1503338381 10:59:41 INFO - starting webserver on 'localhost:44511' 10:59:41 INFO - SUITE-START | Running 2 tests 10:59:41 INFO - TEST-START | dromaeo_css 10:59:41 INFO - Initialising browser for dromaeo_css test... 10:59:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44511/getInfo.html -profile /tmp/tmpsvq5O3/profile 10:59:41 INFO - TEST-INFO | started process 3726 (/builds/slave/test/build/application/firefox/firefox http://localhost:44511/getInfo.html) 10:59:49 INFO - TEST-INFO | 3726: exit 0 10:59:49 INFO - Browser initialized. 10:59:49 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:49 INFO - TEST-INFO | started process 3964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsvq5O3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:50 INFO - PID 3964 | 10:59:50 INFO - PID 3964 | (/builds/slave/test/build/application/firefox/firefox:4014): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:59:50 INFO - PID 3964 | 10:59:51 INFO - PID 3964 | 10:59:51 INFO - PID 3964 | (/builds/slave/test/build/application/firefox/firefox:4073): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:59:51 INFO - PID 3964 | 10:59:51 INFO - PID 3964 | __metrics Screen width/height:1600/1200 10:59:51 INFO - PID 3964 | colorDepth:24 10:59:51 INFO - PID 3964 | Browser inner width/height: 1024/768 10:59:51 INFO - PID 3964 | __metrics 11:00:00 INFO - PID 3964 | RSS: Main: 174182400 11:00:00 INFO - PID 3964 | 11:02:59 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44511/tests/dromaeo/cssquery-ext.html) 11:03:01 INFO - PID 3964 | RSS: Main: 178466816 11:03:01 INFO - PID 3964 | 11:06:03 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-ext.html (next: http://localhost:44511/tests/dromaeo/cssquery-jquery.html) 11:06:03 INFO - PID 3964 | RSS: Main: 175063040 11:06:03 INFO - PID 3964 | 11:09:05 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44511/tests/dromaeo/cssquery-mootools.html) 11:09:06 INFO - PID 3964 | RSS: Main: 177684480 11:09:06 INFO - PID 3964 | 11:12:07 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44511/tests/dromaeo/cssquery-prototype.html) 11:12:08 INFO - PID 3964 | RSS: Main: 175550464 11:12:08 INFO - PID 3964 | 11:15:12 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44511/tests/dromaeo/cssquery-yui.html) 11:15:12 INFO - PID 3964 | RSS: Main: 176766976 11:15:12 INFO - PID 3964 | 11:18:14 INFO - PID 3964 | Cycle 1(1): loaded http://localhost:44511/tests/dromaeo/cssquery-yui.html (next: http://localhost:44511/tests/dromaeo/cssquery-dojo.html) 11:18:15 INFO - PID 3964 | RSS: Main: 179134464 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | __start_tp_report 11:18:15 INFO - PID 3964 | _x_x_mozilla_page_load 11:18:15 INFO - PID 3964 | _x_x_mozilla_page_load_details 11:18:15 INFO - PID 3964 | |i|pagename|runs| 11:18:15 INFO - PID 3964 | |0;dojo.html;3162.746980241581;3187.1713354527824;3197.2006998250436;3212.469942459494;3242.935141297174;6165.660888651122;6270.435660790528;6270.717817698203;6307.495400367971;6311.116443697881;6114.082887566868;6215.254169499666;6219.191505104342;6224.937750622493;6230.750769969207;5696.743646535916;5703.686297253649;5719.942800571983;5724.940885936116;5760.711964401784;5774.913376299338;5798.739056742456;5804.970975145118;5816.883662326751;5885.440883116097;5628.183913332585;5688.60179787415;5723.313202415737;5782.479576838084;5800.941990580082;5461.617686761928;5563.66618002917;5634.211210430543;5698.572607054488;5749.683767392792;5636.267285252932;5657.066584013633;5722.656640601577;5740;5750.108733146369;6077.726502307407;6109.358517355702;6112.816615501542;6153.661548614825;6193.38066193377;6589.308122647101;6592.143021407234;6612.768553100618;6639.2032956045105;6677.432418244455;6797.422219111381;6810.387065164159;6811.897821532681;6815.829604259884;6816.897746533757;6265.467435268008;6279.37206279373;6284.685765711696;6289.371062893765;6304.5271604628915;6887.931120688729;6912.239653638096;6920.134983127109;6980.057692211588;7020.964895175492;6484.319146489645;6573.967130164414;6607.471402287805;6694;6699.6315202663345;6646.302138275508;6647.268800431949;6708.228553716288;6710.127683401224;6712.42944349726;6690.59856408617;6730;6751.021101940191;6751.93248067513;6752;6636.170478690164;6715.093462382613;6716.429103526158;6717.731290748413;6720.563163394364;5353;5420.539254163361;5427.240186373911;5434.728263586884;5440.809571665052;4594.333821595917;4606.723596584216;4617.353570500132;4653.278741795028;4698.083873644675;5783.624064435799;5784.855378615484;5798.768049278066;5803.419658034247;5804.158397032406;6729.293424190488;6736.5958042517605;6817.659117044128;6823.795286141423;6831.760888368884;5284.7093409862055;5750.02249617566;5761.596688231867;5772.422757724194;5786.855328616818;5850.210221620112;5861.325947516005;5874.559408044328;5878.088896221093;5888.705564721747;6503.219613646298;6522.184726909137;6529.967350163314;6531.1509503765155;6605.504587155982;6736.090627765385;6836.5214434989075;6837.521373503807;6837.829054273683;6842.144731908512;6470.126532917996;6471.935280647322;6473.611583305017;6570.638614876228;6578.079068930258;6530.281669016499;6547.9672601638595;6612.206535215805;6619.536632435684;6708.094407254958;6672.099266598947;6744.662766861736;6763.222229443677;6767.323267673193;6844.863102737818;6485.8702825944165;6495.2855185928565;6499.707513162014;6588.736450541925;6589.275179730322;6401.93598064032;6473.741050357933;6484.351564843478;6587.47300215972;6592.373724496165;6444.677766111769;6461.063145843732;6464.773732919325;6475;6484.157059582224;6497.480201583957;6508.219013718384;6542.803715888531;6549.508786840911;6590.077389165424;6295.622262664255;6381.425671689571;6396.136521569529;6400.583962042452;6413.967930160319 11:18:15 INFO - PID 3964 | |1;ext.html;756.3457609168071;816.8284660221353;844.4975239732361;856.2336708645767;1165.819298008809;29228.85385573072;29748.405031899376;40549.79725101374;41639.79180104103;41656;41780;41938.37092443616;42134;42165.15669686604;42386.364204536876;7277.563346199218;7690.5770182639935;7848.097468791077;7872.960635196845;7876.330511906466;7749.457537972344;7753.108392534846;7785.649645765954;7799.961000194991;7825.804354891145;7789.688412463494;7868.842623147533;7871.173526779691;7871.291583757461;7871.881921771178;7851.607419628996;7882.842343153162;7883.132855385903;7883.6058197089915;7883.921160788376;7766.029246344207;7803.258690424401;7808.804779880492;7819.257170568787;7820;36860.447093293624;37204.44193337102;37264.44103338425;37298.25403491915;37328.62671373306;3491.9825400872833;3508.08789714676;3526.2594855080465;3553.307105114504;3553.4314509678584;29950.400991980037;30015;30067.398652026837;30093.69906300931;30135.547966780516;5028.472010438924;5030.723310217936;5050.595952323805;5059.241113832918;5061.848144555669;186980;187147.99999999863;187376;187961;188039;46086.30870536945;46095.30857037147;46245;46382.536174638495;46421.76789116033;47898.5210147901;47993;48084.27873581899;48085;48217;14045.71908561823;15607;15972.201389930457;16022.839771602368;16026.839731602768;11885.762284754257;13177.538786142439;13460.596182114552;13466.730665386638;13473.056886017885;13610.455581776618;13733.725325493633;13740.381682824296;13751.243681597609;13918.930405347908;5524.1989911462615;5601.691906945157;5696.544276457874;5705.258316418839;5803.564732645069;964.4454438697777;981.7938232971013;992.4690290694588;1006.8791744990648;1011.4740335025746;20634.17463301451;20645;20768.792312076686;20898.58202835935;21322.040508177168;1040.3497813866334;1074.7366895110747;1076.838474228872;1082.4039714675148;1087.6193332333778;11821.290722556674;12255.387230638433;12273.69315767095;12324.445399956845;12385.256884586954;233706;235514;236255;236526;236817;49888.251676224885;50279.74860125749;50385;50418.24372634413;50726.74636626793;1400.7478653842202;1423.466200174955;1424.3448013913717;1425.536700572318;1444;22087;22306.888465557568;22437.43906402353;22456.88771556197;22642.094316227165;35919;36122.277554448236;36137.63862361343;36152.45771313485;36199.63800361963;208846;208850;209486;209620;211746;28538.42923141567;32224.83887580547;32434.675653243165;32871;32915;40324;42017;42403;42425;42497.36253956255;30631.387372252877;31230.531542027344;31509.369812604076;31510.52734208943;31608.367832642758;30609.54085688761;31479.370412592078;31530.684693152776;31589.5261571072;31714.84142579272;33827.3234535303;34039.829800850835;34105.97682069542;34286.65713342834;36908.81545592255;33111.00666979994;33435;33470;33787;33867;23816.761832381453;24905.87547062253;24921.875390622932;25340.239792806246;25458.872705636353 11:18:15 INFO - PID 3964 | |2;jquery.html;564.2749067448327;567.5289509706944;587.1222522329118;587.5241054745657;596.9910451343229;21837.67243491349;22600.321990340297;22647.433814154654;22648.660270095963;23354;25097.623535646933;27381.17856464309;27544.449111017766;27563.586546201823;27586.724132758667;6282.057691346312;6416.037594360837;6418.19772528434;6420.967895160517;6438.163038804949;6001.48987336077;6374.330695276999;6515;6533.5753176043645;6560.081588577579;6464.385883341075;6468.514861385392;6469.450096741759;6475.902861457082;6510.414062734353;6516.771912983023;6520.282768895441;6525.902111468285;6528.08606795049;6529.379708927644;6050;6066.272047354301;6070.332263451017;6078.756849726005;6083.239595050619;29460.26349341262;30505.542416863766;30639.693603063908;30664.84667576648;31019.689803101905;1851.6296740651924;1882.190658017052;1882.868199226041;1883.0490602245777;1883.3973128598855;18999.145038473303;19435;20526;20554.07506662189;20617.38147855552;2448.3634255093625;2471.357447063758;2524.2805800346814;2525.2550497603065;2526.9620955685677;146739;153427.23286383608;153525;154059.2297038519;154312;15008.924955375152;15550.533483995498;15579.376824926876;15680.215989200722;15734.606634834221;24180.274591762274;24181;24192.395190120034;24210;24249.51500970006;10391.53238104287;10471.68584942453;10485;10548.314359566604;10754.193435492369;9742.415455072718;9765.951170244103;9792.853107203255;9808.068233517804;9993.950030249802;9487.620495180254;9510.38182518148;9637.37357071788;9641.614335426504;9704.175145112604;2874.18085845533;2883;2894.305366711974;2895.6998856697787;2960.2895305126613;948.137195152408;977.1694060049043;978.0659470205936;985.4432245781254;991.4348821172007;20135.697964530544;20157.798422015887;20404.387868363974;20684.896575517025;20797.792022079888;1034.4827586206898;1035.8394448860438;1036.5698235232294;1036.9429681367596;1038.2472707287156;11160;11312.547498100148;11374;11380.715482112848;11430.542778288942;477691;486089;495781;497348;510575;108685.91314086916;109126.45436772765;109153.45423272833;109621;110734.44632776784;1076.5962763963514;1128.5767837061103;1176.5823132787737;1201.5434135028634;1239.3926975781983;21219.15123395047;21783.564328713655;21838.672419913397;21840.563188736454;22036.559268814854;55296.44703553074;55378.72310638421;55734.16398754103;57439.42560574341;57821;69414;70248.6487567559;70542.64728676324;70795.29204707887;70851;14842.406303748161;15202.847971520143;15209.543713688607;22254.443638909157;22859.19992800244;24381;24996.37509062288;25717.614235786852;25834.87082564575;25847.870760646078;19103.331383401513;19572.21711131539;19796.109175087444;19799.802001980373;19923.402297931087;17386.826131738522;17758.200880960645;17817.73273400926;18022.90988545049;18184.908905465716;19241.615167696847;19922.402327930184;19966.30117945865;20295.4926126848;20374.694379584616;21469.248576299753;21597.784022159576;21713.565728685655;21771.564568708854;22009.11963521441;18402.35591754282;18861.622767544297;19128.904355478135;19159.425217243504;19159.904200478908 11:18:15 INFO - PID 3964 | |3;mootools.html;1360.5034162530678;1401.1382999455334;1419.8296204455467;1432.4198699526696;1441.5315022617651;14025.158490490565;14449.494267700633;14660;14660.633484162901;14687.192204428753;15128.848711512881;15425.382984680627;15429.151396673178;15436.922815385935;15454.69090618187;2584.4572639745675;2607.4263661994332;2657.5083609532203;2666.1335066103497;2667.5065112954167;2663.547196976509;2690.932726681829;2692.1923422973127;2692.609571612115;2693.878775455109;2654.601809728537;2662.4275780707144;2662.853543055131;2668.1595297481326;2686.6775986881603;2604.231751633273;2609.1389841352498;2640.4851054044566;2669.119190667075;2689.677238731355;2641.418887844671;2655.0839960213693;2664.547027005414;2664.653595032653;2678.7053424123333;14095.154290742588;14313.212773297464;14351.78472322916;14381.78427323591;14433.494827680981;7474.813129671747;7743.7676869694;7768.223177682243;7773;7779.611019449061;4944.473561899885;5054.620903432257;5126.179811230222;5160.664556803796;5192.169252919514;1797.73034044893;1801.1534578747967;1805.5125116218678;1809.032167790226;1839.9540011499685;24125.276241712778;24258.757412425828;24302.635460468107;24316.513669726683;24343.87828060866;6283.7800676976085;6303.747850086037;6323.146375239284;6578.736850525926;6582.76960306387;16543;16550.917245413697;16557.172141392883;16572.337106515606;16581.419650312182;7628.656710448043;7775.805604859811;7781.41639377049;7796.571188584682;7799.259070388304;7136.892946605805;7163.7134514619875;7184.820379490555;7248.565086094851;7276.126864776261;4937.506249375106;5191.402988656278;5194.662346947436;5200.843974680765;5204.661696989683;1547.9922600387151;1559.7894284271479;1569.254604063061;1572.7404978178472;1585.1281795012696;815.4373482297196;844.5481667307961;857.8155696525278;868.0841711993907;875.1685898396421;6897.7240910363025;6956.269591692901;6970.721171153097;7001.334873187039;7003.54476958996;688.0951548713426;691.4952084977995;700.3941590524262;709.1490211745926;716.1191734166899;4301.268784306675;4949.455559888409;5449.455054494598;5461.726913654381;5605.831825045255;19954.102065407093;20056.498587535138;20581.897090514452;20591;20793.89603051975;19585.412437626896;19653.50866228356;19973.101210445566;20002.89998549998;20469.59060818805;10789.83815242772;10904.945475272572;11133.053690436403;11160.274582152135;11174.608888688857;7914.0503139623615;8239.134890836376;8256.174382561696;8360.581970901552;8382.622781974704;17089.743653844955;17441.73837392415;17497.30010799554;17670.91164544169;17756.733648995018;17901.283948641907;18031.729524056886;18039.278428863225;18143.548516118943;18351.082445877386;11559.884401155881;11865.762684746429;11867.228630139014;11868.406579671155;11870.228435151688;13229.933850330686;13240.735185296047;13249;13387.330633468093;13425.194488330731;10403.479826008517;10720.785584288427;10738.516766745359;10825.188110891557;10894.237403382003;10401.058174648973;10586.682399528027;10687.198460115367;10716.892831071902;10863.456827158452;8702.56487175626;8820;8828.470291782514;8828.911710883065;8841.867371989554;6892.379685828299;6929.653517324013;6938.23679395256;6951.6871740770775;6977.2673869243;6710.16122984627;6745.460363170836;6810.114685090906;6920.688569014305;6932.410745086522 11:18:15 INFO - PID 3964 | |4;prototype.html;491.7934467523639;500.9555077663072;530.1279395394577;530.4006472685865;533.9893202135956;6193.69031548423;6338.683065846706;6352.36376903585;6356.841078973016;6383.744650213992;6132.669585557482;6175.7529698811995;6192.442680158785;6197.876042479148;6205.689715514229;4915.778789954461;4925.359703238574;5007.724575148365;5030.572401345872;5030.974845125769;4820.975895120519;4882.658213925027;4977.651564390494;4998.40019197695;5004.474530174334;4867.610591152717;4968.22992436173;4998.850034498971;5002.299678045077;5003.849884503471;4991.825286114987;5019.673721208128;5029.2958985742025;5034.496550344973;5046.419661738911;4471.686981911267;4472.910541789179;4485.170243504929;4485.730856148642;4510.706804057726;6122.846928826771;6132.172156758825;6176;6182.567220294536;6215.378462153793;5681.375048744635;5765.1352297155345;5770.134479828017;5779.422057794229;5801.491612180821;6424.775132870327;6502.317256688027;6524.445422139124;6560.704768285439;6606.702698378536;4865.099956508057;4867.9269810952865;4872.731999740013;4895.216765317532;4924.3352147460355;6883.793486195422;6890.345417185359;6922.826929326757;6951.288997291061;7039.507234493536;4933.45731969483;4994.40067191932;4996.375453068366;5016.2224855147515;5038.546530812171;5039.596832253411;5043.9747801260755;5062.949370506321;5076.847694569169;5137.640365174477;5698.458646428583;5746.195532625436;5757.13642953552;5759.568032397587;5760.913586296209;6525.282218955911;6544.872916302125;6584.341565843473;6608.173978252718;6639.2447134439635;1645.7778199943093;1703.4463799265288;1719.785026871641;1727.343609428409;1741.7213245880598;1189.7085214122421;1198.1972078707288;1200.8438902942562;1211.2792888231663;1220.4873952939786;5739.741711622987;5744.569157313218;5769.423057694197;5814.127880817827;5834.212381328552;6436.742530298736;6550.574212676161;6560.212774467094;6690.4647628190605;6747.865042699217;5669.376368599451;5688.8862222755315;5721.313442386941;5735.541156707453;5795.971020144872;3523.6652518010746;3543.309054734302;3544.3442963051402;3566.268914872445;3595.8245261616867;6368.426841584187;6393.456556192683;6453.741850326029;6474.384933431316;6560.442362399154;6791.762288319885;6829.556078854858;6875.828104297432;6885.690143943534;6929.44564434844;6436.195475565554;6517.348265173445;6518.706658200393;6519.4132528072705;6525.21697396306;6681.4298639818635;6701.463882889259;6752.662366881735;6754.628495432602;6802.972677158815;6659.667016649245;6664;6674.799756007327;6690.799276021728;6713.832154196184;6473.546851720523;6479.902801457888;6483.059956306403;6484.962406015015;6511.772087976898;4941.209406494943;4974.900501990012;4991.3296386433085;4996.475370086088;5026.798928042837;6635.7955311783635;6702.530822842355;6746.696398661974;6803.319668033157;6850.349216824394;6418.582792118497;6424.036394540856;6478.805635830932;6511.446527045254;6546.149000629887;6419.069234960998;6419.582727122722;6446.613203207822;6497.577657452251;6535.379138981789;6174.351693072163;6213.316535181217;6337.257254255117;6390.124444000126;6414.583052101785;6499.967500162658;6523.869522609616;6539.378759017885;6555.672216389257;6629.403353697998;6287.46556542699;6319.842003949938;6338.841528961812;6355.777547785805;6377.489800815831 11:18:15 INFO - PID 3964 | |5;yui.html;880.5069161269694;914.1909410171996;915.729859691391;918.972430827075;924.131316562431;18934.715979260305;19692.21231150756;19696.21215151396;19705.99999999998;19876.90061549692;16932.4073657422;17309.567260818487;21052.684209736864;21170.576588468222;21213.469663258427;982.2583949118424;1049.1501883474373;1051.7160366701025;1056.0970370333368;1057.4448414582366;965.555844311614;1062.8883967183451;1068.038765111402;1068.6687126990619;1071.223363061778;1127.3179726265573;1131.564347726123;1133.48992953171;1135.1316243074054;1135.4833550734395;1111.3443068589531;1115.9218854680175;1116.0346300450133;1116.2019156303281;1117.290520519472;812.715549557656;815.1807433529324;815.3029160068115;815.6125840225905;816.3428440105713;20163.495912602157;20366.389008329774;20367.49081272965;20508.897455512775;21022.474438139016;21013.47466313339;21413.35759927189;21523.46191345213;21823.67264491034;22523.436914077116;17026.489205323862;17032.829671703374;17146.056966866818;17205.139743012925;17325.306987720604;3619.69232615228;3647.416413373874;3648.872289469856;3650.1969566695284;3651.214988777399;122288.38855805664;134002;134023;134520.3273983624;138788.30605846905;17936.730949035777;18016.189271482814;18384;18490.260389584535;18532.536686582942;31860.522092168638;32126;32135.357292854012;32276;32728.836355818068;8574.442661227;8698.304135669132;8758.036615972238;8778.078301778349;8827.823443531093;4050.7974601270407;4080.571539988318;4109.465769449952;4133.297339452301;4147.854825081107;5015.573676237488;5092.439831618519;5098.1842905135;5132.1788513838355;5140.151874940593;1032.865727455441;1040.3393844908537;1045.430240518919;1049.165913099073;1049.9265051446325;670.735059651435;687.4431710314661;689.2005273882272;697.6476879175983;710.9939435698532;11240.662780116609;11671.241369310968;13345.532906348231;13390;13590.864091359157;617.586217234454;623.6788054152115;643.7585905285518;647.795944277551;678.4097834883682;5390.703511306838;5411.56707463402;5455.236266922634;5622.887542249214;5719.799807006735;106657;109881;109948;111338.44330778456;113465;97953;97983.51008244914;98163.50918245364;99541;99614;83672.58163709143;85134.57432712796;85192.57403713066;85308.14691853126;86104;10201.74495637615;10324.741881453023;10358.637447689294;10371.429571373646;10556.472176390997;39612;39637.80181099076;39877.60122398739;41406.171876562905;41940.161196776506;71662.64168679123;71995;72400;73935;75223.62388188243;18658.720119198493;18667.813321866608;19028.619427611648;19662.410127696192;19726.50683732861;20897.37307880766;21382.893085534473;21462.892685536473;21515.569688606454;21726;16874.240659170613;17355.56611084733;18280.177392017657;18290.35983740616;18302.633947321247;16245.675086497968;16293.266802993656;16856.410025649042;16857.409990650267;17003;17160.828391715924;17471;17987.820121799137;18071.819281807013;18247.81752182461;12511;12766.936165319114;12769.744605108031;12916.677083072998;13087.887529560094;14212.928935355258;14337.498187563386;14626.367253894401;14692.045017073857;14843.257837107885 11:18:15 INFO - PID 3964 | __end_tp_report 11:18:15 INFO - PID 3964 | __start_cc_report 11:18:15 INFO - PID 3964 | _x_x_mozilla_cycle_collect,396 11:18:15 INFO - PID 3964 | __end_cc_report 11:18:15 INFO - PID 3964 | __startTimestamp1503339495008__endTimestamp 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | ------- Summary: start ------- 11:18:15 INFO - PID 3964 | Number of tests: 6 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | [#0] dojo.html Cycles:165 Average:6169.74 Median:6461.06 stddev:736.17 (11.4%) stddev-sans-first:699.61 11:18:15 INFO - PID 3964 | Values: 3162.7 3187.2 3197.2 3212.5 3242.9 6165.7 6270.4 6270.7 6307.5 6311.1 6114.1 6215.3 6219.2 6224.9 6230.8 5696.7 5703.7 5719.9 5724.9 5760.7 5774.9 5798.7 5805.0 5816.9 5885.4 5628.2 5688.6 5723.3 5782.5 5800.9 5461.6 5563.7 5634.2 5698.6 5749.7 5636.3 5657.1 5722.7 5740.0 5750.1 6077.7 6109.4 6112.8 6153.7 6193.4 6589.3 6592.1 6612.8 6639.2 6677.4 6797.4 6810.4 6811.9 6815.8 6816.9 6265.5 6279.4 6284.7 6289.4 6304.5 6887.9 6912.2 6920.1 6980.1 7021.0 6484.3 6574.0 6607.5 6694.0 6699.6 6646.3 6647.3 6708.2 6710.1 6712.4 6690.6 6730.0 6751.0 6751.9 6752.0 6636.2 6715.1 6716.4 6717.7 6720.6 5353.0 5420.5 5427.2 5434.7 5440.8 4594.3 4606.7 4617.4 4653.3 4698.1 5783.6 5784.9 5798.8 5803.4 5804.2 6729.3 6736.6 6817.7 6823.8 6831.8 5284.7 5750.0 5761.6 5772.4 5786.9 5850.2 5861.3 5874.6 5878.1 5888.7 6503.2 6522.2 6530.0 6531.2 6605.5 6736.1 6836.5 6837.5 6837.8 6842.1 6470.1 6471.9 6473.6 6570.6 6578.1 6530.3 6548.0 6612.2 6619.5 6708.1 6672.1 6744.7 6763.2 6767.3 6844.9 6485.9 6495.3 6499.7 6588.7 6589.3 6401.9 6473.7 6484.4 6587.5 6592.4 6444.7 6461.1 6464.8 6475.0 6484.2 6497.5 6508.2 6542.8 6549.5 6590.1 6295.6 6381.4 6396.1 6400.6 6414.0 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | [#1] ext.html Cycles:180 Average:37348.77 Median:33953.41 stddev:54917.04 (161.7%) stddev-sans-first:55002.37 11:18:15 INFO - PID 3964 | Values: 756.3 816.8 844.5 856.2 1165.8 29228.9 29748.4 40549.8 41639.8 41656.0 41780.0 41938.4 42134.0 42165.2 42386.4 7277.6 7690.6 7848.1 7873.0 7876.3 7749.5 7753.1 7785.6 7800.0 7825.8 7789.7 7868.8 7871.2 7871.3 7871.9 7851.6 7882.8 7883.1 7883.6 7883.9 7766.0 7803.3 7808.8 7819.3 7820.0 36860.4 37204.4 37264.4 37298.3 37328.6 3492.0 3508.1 3526.3 3553.3 3553.4 29950.4 30015.0 30067.4 30093.7 30135.5 5028.5 5030.7 5050.6 5059.2 5061.8 186980.0 187148.0 187376.0 187961.0 188039.0 46086.3 46095.3 46245.0 46382.5 46421.8 47898.5 47993.0 48084.3 48085.0 48217.0 14045.7 15607.0 15972.2 16022.8 16026.8 11885.8 13177.5 13460.6 13466.7 13473.1 13610.5 13733.7 13740.4 13751.2 13918.9 5524.2 5601.7 5696.5 5705.3 5803.6 964.4 981.8 992.5 1006.9 1011.5 20634.2 20645.0 20768.8 20898.6 21322.0 1040.3 1074.7 1076.8 1082.4 1087.6 11821.3 12255.4 12273.7 12324.4 12385.3 233706.0 235514.0 236255.0 236526.0 236817.0 49888.3 50279.7 50385.0 50418.2 50726.7 1400.7 1423.5 1424.3 1425.5 1444.0 22087.0 22306.9 22437.4 22456.9 22642.1 35919.0 36122.3 36137.6 36152.5 36199.6 208846.0 208850.0 209486.0 209620.0 211746.0 28538.4 32224.8 32434.7 32871.0 32915.0 40324.0 42017.0 42403.0 42425.0 42497.4 30631.4 31230.5 31509.4 31510.5 31608.4 30609.5 31479.4 31530.7 31589.5 31714.8 33827.3 34039.8 34106.0 34286.7 36908.8 33111.0 33435.0 33470.0 33787.0 33867.0 23816.8 24905.9 24921.9 25340.2 25458.9 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | [#2] jquery.html Cycles:180 Average:35827.83 Median:24180.64 stddev:83341.26 (344.7%) stddev-sans-first:83532.99 11:18:15 INFO - PID 3964 | Values: 564.3 567.5 587.1 587.5 597.0 21837.7 22600.3 22647.4 22648.7 23354.0 25097.6 27381.2 27544.4 27563.6 27586.7 6282.1 6416.0 6418.2 6421.0 6438.2 6001.5 6374.3 6515.0 6533.6 6560.1 6464.4 6468.5 6469.5 6475.9 6510.4 6516.8 6520.3 6525.9 6528.1 6529.4 6050.0 6066.3 6070.3 6078.8 6083.2 29460.3 30505.5 30639.7 30664.8 31019.7 1851.6 1882.2 1882.9 1883.0 1883.4 18999.1 19435.0 20526.0 20554.1 20617.4 2448.4 2471.4 2524.3 2525.3 2527.0 146739.0 153427.2 153525.0 154059.2 154312.0 15008.9 15550.5 15579.4 15680.2 15734.6 24180.3 24181.0 24192.4 24210.0 24249.5 10391.5 10471.7 10485.0 10548.3 10754.2 9742.4 9766.0 9792.9 9808.1 9994.0 9487.6 9510.4 9637.4 9641.6 9704.2 2874.2 2883.0 2894.3 2895.7 2960.3 948.1 977.2 978.1 985.4 991.4 20135.7 20157.8 20404.4 20684.9 20797.8 1034.5 1035.8 1036.6 1036.9 1038.2 11160.0 11312.5 11374.0 11380.7 11430.5 477691.0 486089.0 495781.0 497348.0 510575.0 108685.9 109126.5 109153.5 109621.0 110734.4 1076.6 1128.6 1176.6 1201.5 1239.4 21219.2 21783.6 21838.7 21840.6 22036.6 55296.4 55378.7 55734.2 57439.4 57821.0 69414.0 70248.6 70542.6 70795.3 70851.0 14842.4 15202.8 15209.5 22254.4 22859.2 24381.0 24996.4 25717.6 25834.9 25847.9 19103.3 19572.2 19796.1 19799.8 19923.4 17386.8 17758.2 17817.7 18022.9 18184.9 19241.6 19922.4 19966.3 20295.5 20374.7 21469.2 21597.8 21713.6 21771.6 22009.1 18402.4 18861.6 19128.9 19159.4 19159.9 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | [#3] mootools.html Cycles:180 Average:8897.79 Median:2648.01 stddev:6260.15 (236.4%) stddev-sans-first:6252.10 11:18:15 INFO - PID 3964 | Values: 1360.5 1401.1 1419.8 1432.4 1441.5 14025.2 14449.5 14660.0 14660.6 14687.2 15128.8 15425.4 15429.2 15436.9 15454.7 2584.5 2607.4 2657.5 2666.1 2667.5 2663.5 2690.9 2692.2 2692.6 2693.9 2654.6 2662.4 2662.9 2668.2 2686.7 2604.2 2609.1 2640.5 2669.1 2689.7 2641.4 2655.1 2664.5 2664.7 2678.7 14095.2 14313.2 14351.8 14381.8 14433.5 7474.8 7743.8 7768.2 7773.0 7779.6 4944.5 5054.6 5126.2 5160.7 5192.2 1797.7 1801.2 1805.5 1809.0 1840.0 24125.3 24258.8 24302.6 24316.5 24343.9 6283.8 6303.7 6323.1 6578.7 6582.8 16543.0 16550.9 16557.2 16572.3 16581.4 7628.7 7775.8 7781.4 7796.6 7799.3 7136.9 7163.7 7184.8 7248.6 7276.1 4937.5 5191.4 5194.7 5200.8 5204.7 1548.0 1559.8 1569.3 1572.7 1585.1 815.4 844.5 857.8 868.1 875.2 6897.7 6956.3 6970.7 7001.3 7003.5 688.1 691.5 700.4 709.1 716.1 4301.3 4949.5 5449.5 5461.7 5605.8 19954.1 20056.5 20581.9 20591.0 20793.9 19585.4 19653.5 19973.1 20002.9 20469.6 10789.8 10904.9 11133.1 11160.3 11174.6 7914.1 8239.1 8256.2 8360.6 8382.6 17089.7 17441.7 17497.3 17670.9 17756.7 17901.3 18031.7 18039.3 18143.5 18351.1 11559.9 11865.8 11867.2 11868.4 11870.2 13229.9 13240.7 13249.0 13387.3 13425.2 10403.5 10720.8 10738.5 10825.2 10894.2 10401.1 10586.7 10687.2 10716.9 10863.5 8702.6 8820.0 8828.5 8828.9 8841.9 6892.4 6929.7 6938.2 6951.7 6977.3 6710.2 6745.5 6810.1 6920.7 6932.4 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | [#4] prototype.html Cycles:180 Average:5506.60 Median:6179.28 stddev:1546.44 (25.0%) stddev-sans-first:1504.27 11:18:15 INFO - PID 3964 | Values: 491.8 501.0 530.1 530.4 534.0 6193.7 6338.7 6352.4 6356.8 6383.7 6132.7 6175.8 6192.4 6197.9 6205.7 4915.8 4925.4 5007.7 5030.6 5031.0 4821.0 4882.7 4977.7 4998.4 5004.5 4867.6 4968.2 4998.9 5002.3 5003.8 4991.8 5019.7 5029.3 5034.5 5046.4 4471.7 4472.9 4485.2 4485.7 4510.7 6122.8 6132.2 6176.0 6182.6 6215.4 5681.4 5765.1 5770.1 5779.4 5801.5 6424.8 6502.3 6524.4 6560.7 6606.7 4865.1 4867.9 4872.7 4895.2 4924.3 6883.8 6890.3 6922.8 6951.3 7039.5 4933.5 4994.4 4996.4 5016.2 5038.5 5039.6 5044.0 5062.9 5076.8 5137.6 5698.5 5746.2 5757.1 5759.6 5760.9 6525.3 6544.9 6584.3 6608.2 6639.2 1645.8 1703.4 1719.8 1727.3 1741.7 1189.7 1198.2 1200.8 1211.3 1220.5 5739.7 5744.6 5769.4 5814.1 5834.2 6436.7 6550.6 6560.2 6690.5 6747.9 5669.4 5688.9 5721.3 5735.5 5796.0 3523.7 3543.3 3544.3 3566.3 3595.8 6368.4 6393.5 6453.7 6474.4 6560.4 6791.8 6829.6 6875.8 6885.7 6929.4 6436.2 6517.3 6518.7 6519.4 6525.2 6681.4 6701.5 6752.7 6754.6 6803.0 6659.7 6664.0 6674.8 6690.8 6713.8 6473.5 6479.9 6483.1 6485.0 6511.8 4941.2 4974.9 4991.3 4996.5 5026.8 6635.8 6702.5 6746.7 6803.3 6850.3 6418.6 6424.0 6478.8 6511.4 6546.1 6419.1 6419.6 6446.6 6497.6 6535.4 6174.4 6213.3 6337.3 6390.1 6414.6 6500.0 6523.9 6539.4 6555.7 6629.4 6287.5 6319.8 6338.8 6355.8 6377.5 11:18:15 INFO - PID 3964 | 11:18:15 INFO - PID 3964 | [#5] yui.html Cycles:180 Average:24107.14 Median:20264.94 stddev:32884.11 (162.3%) stddev-sans-first:32930.11 11:18:15 INFO - PID 3964 | Values: 880.5 914.2 915.7 919.0 924.1 18934.7 19692.2 19696.2 19706.0 19876.9 16932.4 17309.6 21052.7 21170.6 21213.5 982.3 1049.2 1051.7 1056.1 1057.4 965.6 1062.9 1068.0 1068.7 1071.2 1127.3 1131.6 1133.5 1135.1 1135.5 1111.3 1115.9 1116.0 1116.2 1117.3 812.7 815.2 815.3 815.6 816.3 20163.5 20366.4 20367.5 20508.9 21022.5 21013.5 21413.4 21523.5 21823.7 22523.4 17026.5 17032.8 17146.1 17205.1 17325.3 3619.7 3647.4 3648.9 3650.2 3651.2 122288.4 134002.0 134023.0 134520.3 138788.3 17936.7 18016.2 18384.0 18490.3 18532.5 31860.5 32126.0 32135.4 32276.0 32728.8 8574.4 8698.3 8758.0 8778.1 8827.8 4050.8 4080.6 4109.5 4133.3 4147.9 5015.6 5092.4 5098.2 5132.2 5140.2 1032.9 1040.3 1045.4 1049.2 1049.9 670.7 687.4 689.2 697.6 711.0 11240.7 11671.2 13345.5 13390.0 13590.9 617.6 623.7 643.8 647.8 678.4 5390.7 5411.6 5455.2 5622.9 5719.8 106657.0 109881.0 109948.0 111338.4 113465.0 97953.0 97983.5 98163.5 99541.0 99614.0 83672.6 85134.6 85192.6 85308.1 86104.0 10201.7 10324.7 10358.6 10371.4 10556.5 39612.0 39637.8 39877.6 41406.2 41940.2 71662.6 71995.0 72400.0 73935.0 75223.6 18658.7 18667.8 19028.6 19662.4 19726.5 20897.4 21382.9 21462.9 21515.6 21726.0 16874.2 17355.6 18280.2 18290.4 18302.6 16245.7 16293.3 16856.4 16857.4 17003.0 17160.8 17471.0 17987.8 18071.8 18247.8 12511.0 12766.9 12769.7 12916.7 13087.9 14212.9 14337.5 14626.4 14692.0 14843.3 11:18:15 INFO - PID 3964 | -------- Summary: end -------- 11:18:15 INFO - PID 3964 | 11:18:15 INFO - TEST-INFO | 3964: exit 0 11:18:15 INFO - TEST-OK | dromaeo_css | took 1114373ms 11:18:15 INFO - TEST-START | kraken 11:18:15 INFO - Initialising browser for kraken test... 11:18:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44511/getInfo.html -profile /tmp/tmpG_GGch/profile 11:18:15 INFO - TEST-INFO | started process 4389 (/builds/slave/test/build/application/firefox/firefox http://localhost:44511/getInfo.html) 11:18:21 INFO - TEST-INFO | 4389: exit 0 11:18:21 INFO - Browser initialized. 11:18:21 INFO - Running cycle 1/1 for kraken test... 11:18:21 INFO - TEST-INFO | started process 4576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_GGch/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:22 INFO - PID 4576 | 11:18:22 INFO - PID 4576 | (/builds/slave/test/build/application/firefox/firefox:4627): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:22 INFO - PID 4576 | 11:18:23 INFO - PID 4576 | 11:18:23 INFO - PID 4576 | (/builds/slave/test/build/application/firefox/firefox:4687): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:23 INFO - PID 4576 | 11:18:23 INFO - PID 4576 | __metrics Screen width/height:1600/1200 11:18:23 INFO - PID 4576 | colorDepth:24 11:18:23 INFO - PID 4576 | Browser inner width/height: 1024/768 11:18:23 INFO - PID 4576 | __metrics 11:18:33 INFO - PID 4576 | RSS: Main: 174534656 11:18:33 INFO - PID 4576 | 11:18:35 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:36 INFO - PID 4576 | RSS: Main: 178679808 11:18:36 INFO - PID 4576 | 11:18:39 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-dft) 11:18:40 INFO - PID 4576 | RSS: Main: 179040256 11:18:40 INFO - PID 4576 | 11:18:43 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-fft) 11:18:43 INFO - PID 4576 | RSS: Main: 173117440 11:18:43 INFO - PID 4576 | 11:18:46 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44511/tests/kraken/driver.html?testName=audio-oscillator) 11:18:46 INFO - PID 4576 | RSS: Main: 174030848 11:18:46 INFO - PID 4576 | 11:18:48 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:49 INFO - PID 4576 | RSS: Main: 174723072 11:18:49 INFO - PID 4576 | 11:18:52 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44511/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:53 INFO - PID 4576 | RSS: Main: 175337472 11:18:53 INFO - PID 4576 | 11:18:56 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44511/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:57 INFO - PID 4576 | RSS: Main: 175681536 11:18:57 INFO - PID 4576 | 11:19:00 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44511/tests/kraken/driver.html?testName=json-parse-financial) 11:19:01 INFO - PID 4576 | RSS: Main: 176504832 11:19:01 INFO - PID 4576 | 11:19:02 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:19:03 INFO - PID 4576 | RSS: Main: 176459776 11:19:03 INFO - PID 4576 | 11:19:05 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:05 INFO - PID 4576 | RSS: Main: 176648192 11:19:05 INFO - PID 4576 | 11:19:08 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:08 INFO - PID 4576 | RSS: Main: 176209920 11:19:08 INFO - PID 4576 | 11:19:11 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:12 INFO - PID 4576 | RSS: Main: 176594944 11:19:12 INFO - PID 4576 | 11:19:15 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:15 INFO - PID 4576 | RSS: Main: 176652288 11:19:15 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | Cycle 1(1): loaded http://localhost:44511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44511/tests/kraken/driver.html?testName=ai-astar) 11:19:17 INFO - PID 4576 | RSS: Main: 178323456 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | __start_tp_report 11:19:17 INFO - PID 4576 | _x_x_mozilla_page_load 11:19:17 INFO - PID 4576 | _x_x_mozilla_page_load_details 11:19:17 INFO - PID 4576 | |i|pagename|runs| 11:19:17 INFO - PID 4576 | |0;ai-astar;101;108;103;107;107;111;108;103;114;109 11:19:17 INFO - PID 4576 | |1;audio-beat-detection;143;120;149;184;135;145;153;119;175;121 11:19:17 INFO - PID 4576 | |2;audio-dft;169;164;162;162;164;163;171;166;164;164 11:19:17 INFO - PID 4576 | |3;audio-fft;76;78;76;172;80;86;74;74;161;76 11:19:17 INFO - PID 4576 | |4;audio-oscillator;82;78;125;82;79;87;135;80;79;155 11:19:17 INFO - PID 4576 | |5;imaging-gaussian-blur;114;119;114;114;121;114;114;114;117;117 11:19:17 INFO - PID 4576 | |6;imaging-darkroom;151;151;151;150;149;149;151;151;150;151 11:19:17 INFO - PID 4576 | |7;imaging-desaturate;98;94;94;95;95;95;94;95;94;94 11:19:17 INFO - PID 4576 | |8;json-parse-financial;55;54;57;56;54;58;55;54;53;56 11:19:17 INFO - PID 4576 | |9;json-stringify-tinderbox;62;55;54;54;54;54;61;55;60;59 11:19:17 INFO - PID 4576 | |10;stanford-crypto-aes;77;74;80;73;75;79;77;74;77;79 11:19:17 INFO - PID 4576 | |11;stanford-crypto-ccm;123;127;130;137;118;118;137;126;122;163 11:19:17 INFO - PID 4576 | |12;stanford-crypto-pbkdf2;172;182;183;173;175;174;178;175;177;170 11:19:17 INFO - PID 4576 | |13;stanford-crypto-sha256-iterative;68;68;77;68;67;66;65;64;67;68 11:19:17 INFO - PID 4576 | __end_tp_report 11:19:17 INFO - PID 4576 | __start_cc_report 11:19:17 INFO - PID 4576 | _x_x_mozilla_cycle_collect,994 11:19:17 INFO - PID 4576 | __end_cc_report 11:19:17 INFO - PID 4576 | __startTimestamp1503339557822__endTimestamp 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | ------- Summary: start ------- 11:19:17 INFO - PID 4576 | Number of tests: 14 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#0] ai-astar Cycles:10 Average:107.10 Median:108.00 stddev:3.93 (3.6%) stddev-sans-first:3.49 11:19:17 INFO - PID 4576 | Values: 101.0 108.0 103.0 107.0 107.0 111.0 108.0 103.0 114.0 109.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:147.00 stddev:22.31 (15.2%) stddev-sans-first:23.65 11:19:17 INFO - PID 4576 | Values: 143.0 120.0 149.0 184.0 135.0 145.0 153.0 119.0 175.0 121.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:2.96 (1.8%) stddev-sans-first:2.74 11:19:17 INFO - PID 4576 | Values: 169.0 164.0 162.0 162.0 164.0 163.0 171.0 166.0 164.0 164.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:37.78 (49.7%) stddev-sans-first:39.42 11:19:17 INFO - PID 4576 | Values: 76.0 78.0 76.0 172.0 80.0 86.0 74.0 74.0 161.0 76.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:79.50 stddev:28.72 (36.1%) stddev-sans-first:29.86 11:19:17 INFO - PID 4576 | Values: 82.0 78.0 125.0 82.0 79.0 87.0 135.0 80.0 79.0 155.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.50 stddev:2.57 (2.2%) stddev-sans-first:2.65 11:19:17 INFO - PID 4576 | Values: 114.0 119.0 114.0 114.0 121.0 114.0 114.0 114.0 117.0 117.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 11:19:17 INFO - PID 4576 | Values: 151.0 151.0 151.0 150.0 149.0 149.0 151.0 151.0 150.0 151.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:0.53 11:19:17 INFO - PID 4576 | Values: 98.0 94.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.55 (2.8%) stddev-sans-first:1.64 11:19:17 INFO - PID 4576 | Values: 55.0 54.0 57.0 56.0 54.0 58.0 55.0 54.0 53.0 56.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:3.29 (5.8%) stddev-sans-first:2.91 11:19:17 INFO - PID 4576 | Values: 62.0 55.0 54.0 54.0 54.0 54.0 61.0 55.0 60.0 59.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.00 stddev:2.42 (3.1%) stddev-sans-first:2.55 11:19:17 INFO - PID 4576 | Values: 77.0 74.0 80.0 73.0 75.0 79.0 77.0 74.0 77.0 79.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:128.50 stddev:13.39 (10.4%) stddev-sans-first:13.95 11:19:17 INFO - PID 4576 | Values: 123.0 127.0 130.0 137.0 118.0 118.0 137.0 126.0 122.0 163.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:176.00 stddev:4.18 (2.4%) stddev-sans-first:4.18 11:19:17 INFO - PID 4576 | Values: 172.0 182.0 183.0 173.0 175.0 174.0 178.0 175.0 177.0 170.0 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:3.52 (5.2%) stddev-sans-first:3.73 11:19:17 INFO - PID 4576 | Values: 68.0 68.0 77.0 68.0 67.0 66.0 65.0 64.0 67.0 68.0 11:19:17 INFO - PID 4576 | -------- Summary: end -------- 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | 11:19:17 INFO - PID 4576 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:19:17 INFO - PID 4576 | 11:19:18 INFO - PID 4576 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:19:18 INFO - TEST-INFO | 4576: exit 0 11:19:18 INFO - TEST-OK | kraken | took 62731ms 11:19:18 INFO - SUITE-END | took 1177s 11:19:18 INFO - Completed test suite (00:19:37) 11:19:18 INFO - javascript benchmark 11:19:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8523.224829708897, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.746980241581, 3187.1713354527824, 3197.2006998250436, 3212.469942459494, 3242.935141297174, 6165.660888651122, 6270.435660790528, 6270.717817698203, 6307.495400367971, 6311.116443697881, 6114.082887566868, 6215.254169499666, 6219.191505104342, 6224.937750622493, 6230.750769969207, 5696.743646535916, 5703.686297253649, 5719.942800571983, 5724.940885936116, 5760.711964401784, 5774.913376299338, 5798.739056742456, 5804.970975145118, 5816.883662326751, 5885.440883116097, 5628.183913332585, 5688.60179787415, 5723.313202415737, 5782.479576838084, 5800.941990580082, 5461.617686761928, 5563.66618002917, 5634.211210430543, 5698.572607054488, 5749.683767392792, 5636.267285252932, 5657.066584013633, 5722.656640601577, 5740.0, 5750.108733146369, 6077.726502307407, 6109.358517355702, 6112.816615501542, 6153.661548614825, 6193.38066193377, 6589.308122647101, 6592.143021407234, 6612.768553100618, 6639.2032956045105, 6677.432418244455, 6797.422219111381, 6810.387065164159, 6811.897821532681, 6815.829604259884, 6816.897746533757, 6265.467435268008, 6279.37206279373, 6284.685765711696, 6289.371062893765, 6304.5271604628915, 6887.931120688729, 6912.239653638096, 6920.134983127109, 6980.057692211588, 7020.964895175492, 6484.319146489645, 6573.967130164414, 6607.471402287805, 6694.0, 6699.6315202663345, 6646.302138275508, 6647.268800431949, 6708.228553716288, 6710.127683401224, 6712.42944349726, 6690.59856408617, 6730.0, 6751.021101940191, 6751.93248067513, 6752.0, 6636.170478690164, 6715.093462382613, 6716.429103526158, 6717.731290748413, 6720.563163394364, 5353.0, 5420.539254163361, 5427.240186373911, 5434.728263586884, 5440.809571665052, 4594.333821595917, 4606.723596584216, 4617.353570500132, 4653.278741795028, 4698.083873644675, 5783.624064435799, 5784.855378615484, 5798.768049278066, 5803.419658034247, 5804.158397032406, 6729.293424190488, 6736.5958042517605, 6817.659117044128, 6823.795286141423, 6831.760888368884, 5284.7093409862055, 5750.02249617566, 5761.596688231867, 5772.422757724194, 5786.855328616818, 5850.210221620112, 5861.325947516005, 5874.559408044328, 5878.088896221093, 5888.705564721747, 6503.219613646298, 6522.184726909137, 6529.967350163314, 6531.1509503765155, 6605.504587155982, 6736.090627765385, 6836.5214434989075, 6837.521373503807, 6837.829054273683, 6842.144731908512, 6470.126532917996, 6471.935280647322, 6473.611583305017, 6570.638614876228, 6578.079068930258, 6530.281669016499, 6547.9672601638595, 6612.206535215805, 6619.536632435684, 6708.094407254958, 6672.099266598947, 6744.662766861736, 6763.222229443677, 6767.323267673193, 6844.863102737818, 6485.8702825944165, 6495.2855185928565, 6499.707513162014, 6588.736450541925, 6589.275179730322, 6401.93598064032, 6473.741050357933, 6484.351564843478, 6587.47300215972, 6592.373724496165, 6444.677766111769, 6461.063145843732, 6464.773732919325, 6475.0, 6484.157059582224, 6497.480201583957, 6508.219013718384, 6542.803715888531, 6549.508786840911, 6590.077389165424, 6295.622262664255, 6381.425671689571, 6396.136521569529, 6400.583962042452, 6413.967930160319], "value": 6114.607344921146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.3457609168071, 816.8284660221353, 844.4975239732361, 856.2336708645767, 1165.819298008809, 29228.85385573072, 29748.405031899376, 40549.79725101374, 41639.79180104103, 41656.0, 41780.0, 41938.37092443616, 42134.0, 42165.15669686604, 42386.364204536876, 7277.563346199218, 7690.5770182639935, 7848.097468791077, 7872.960635196845, 7876.330511906466, 7749.457537972344, 7753.108392534846, 7785.649645765954, 7799.961000194991, 7825.804354891145, 7789.688412463494, 7868.842623147533, 7871.173526779691, 7871.291583757461, 7871.881921771178, 7851.607419628996, 7882.842343153162, 7883.132855385903, 7883.6058197089915, 7883.921160788376, 7766.029246344207, 7803.258690424401, 7808.804779880492, 7819.257170568787, 7820.0, 36860.447093293624, 37204.44193337102, 37264.44103338425, 37298.25403491915, 37328.62671373306, 3491.9825400872833, 3508.08789714676, 3526.2594855080465, 3553.307105114504, 3553.4314509678584, 29950.400991980037, 30015.0, 30067.398652026837, 30093.69906300931, 30135.547966780516, 5028.472010438924, 5030.723310217936, 5050.595952323805, 5059.241113832918, 5061.848144555669, 186980.0, 187147.99999999863, 187376.0, 187961.0, 188039.0, 46086.30870536945, 46095.30857037147, 46245.0, 46382.536174638495, 46421.76789116033, 47898.5210147901, 47993.0, 48084.27873581899, 48085.0, 48217.0, 14045.71908561823, 15607.0, 15972.201389930457, 16022.839771602368, 16026.839731602768, 11885.762284754257, 13177.538786142439, 13460.596182114552, 13466.730665386638, 13473.056886017885, 13610.455581776618, 13733.725325493633, 13740.381682824296, 13751.243681597609, 13918.930405347908, 5524.1989911462615, 5601.691906945157, 5696.544276457874, 5705.258316418839, 5803.564732645069, 964.4454438697777, 981.7938232971013, 992.4690290694588, 1006.8791744990648, 1011.4740335025746, 20634.17463301451, 20645.0, 20768.792312076686, 20898.58202835935, 21322.040508177168, 1040.3497813866334, 1074.7366895110747, 1076.838474228872, 1082.4039714675148, 1087.6193332333778, 11821.290722556674, 12255.387230638433, 12273.69315767095, 12324.445399956845, 12385.256884586954, 233706.0, 235514.0, 236255.0, 236526.0, 236817.0, 49888.251676224885, 50279.74860125749, 50385.0, 50418.24372634413, 50726.74636626793, 1400.7478653842202, 1423.466200174955, 1424.3448013913717, 1425.536700572318, 1444.0, 22087.0, 22306.888465557568, 22437.43906402353, 22456.88771556197, 22642.094316227165, 35919.0, 36122.277554448236, 36137.63862361343, 36152.45771313485, 36199.63800361963, 208846.0, 208850.0, 209486.0, 209620.0, 211746.0, 28538.42923141567, 32224.83887580547, 32434.675653243165, 32871.0, 32915.0, 40324.0, 42017.0, 42403.0, 42425.0, 42497.36253956255, 30631.387372252877, 31230.531542027344, 31509.369812604076, 31510.52734208943, 31608.367832642758, 30609.54085688761, 31479.370412592078, 31530.684693152776, 31589.5261571072, 31714.84142579272, 33827.3234535303, 34039.829800850835, 34105.97682069542, 34286.65713342834, 36908.81545592255, 33111.00666979994, 33435.0, 33470.0, 33787.0, 33867.0, 23816.761832381453, 24905.87547062253, 24921.875390622932, 25340.239792806246, 25458.872705636353], "value": 16880.024988816047, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2749067448327, 567.5289509706944, 587.1222522329118, 587.5241054745657, 596.9910451343229, 21837.67243491349, 22600.321990340297, 22647.433814154654, 22648.660270095963, 23354.0, 25097.623535646933, 27381.17856464309, 27544.449111017766, 27563.586546201823, 27586.724132758667, 6282.057691346312, 6416.037594360837, 6418.19772528434, 6420.967895160517, 6438.163038804949, 6001.48987336077, 6374.330695276999, 6515.0, 6533.5753176043645, 6560.081588577579, 6464.385883341075, 6468.514861385392, 6469.450096741759, 6475.902861457082, 6510.414062734353, 6516.771912983023, 6520.282768895441, 6525.902111468285, 6528.08606795049, 6529.379708927644, 6050.0, 6066.272047354301, 6070.332263451017, 6078.756849726005, 6083.239595050619, 29460.26349341262, 30505.542416863766, 30639.693603063908, 30664.84667576648, 31019.689803101905, 1851.6296740651924, 1882.190658017052, 1882.868199226041, 1883.0490602245777, 1883.3973128598855, 18999.145038473303, 19435.0, 20526.0, 20554.07506662189, 20617.38147855552, 2448.3634255093625, 2471.357447063758, 2524.2805800346814, 2525.2550497603065, 2526.9620955685677, 146739.0, 153427.23286383608, 153525.0, 154059.2297038519, 154312.0, 15008.924955375152, 15550.533483995498, 15579.376824926876, 15680.215989200722, 15734.606634834221, 24180.274591762274, 24181.0, 24192.395190120034, 24210.0, 24249.51500970006, 10391.53238104287, 10471.68584942453, 10485.0, 10548.314359566604, 10754.193435492369, 9742.415455072718, 9765.951170244103, 9792.853107203255, 9808.068233517804, 9993.950030249802, 9487.620495180254, 9510.38182518148, 9637.37357071788, 9641.614335426504, 9704.175145112604, 2874.18085845533, 2883.0, 2894.305366711974, 2895.6998856697787, 2960.2895305126613, 948.137195152408, 977.1694060049043, 978.0659470205936, 985.4432245781254, 991.4348821172007, 20135.697964530544, 20157.798422015887, 20404.387868363974, 20684.896575517025, 20797.792022079888, 1034.4827586206898, 1035.8394448860438, 1036.5698235232294, 1036.9429681367596, 1038.2472707287156, 11160.0, 11312.547498100148, 11374.0, 11380.715482112848, 11430.542778288942, 477691.0, 486089.0, 495781.0, 497348.0, 510575.0, 108685.91314086916, 109126.45436772765, 109153.45423272833, 109621.0, 110734.44632776784, 1076.5962763963514, 1128.5767837061103, 1176.5823132787737, 1201.5434135028634, 1239.3926975781983, 21219.15123395047, 21783.564328713655, 21838.672419913397, 21840.563188736454, 22036.559268814854, 55296.44703553074, 55378.72310638421, 55734.16398754103, 57439.42560574341, 57821.0, 69414.0, 70248.6487567559, 70542.64728676324, 70795.29204707887, 70851.0, 14842.406303748161, 15202.847971520143, 15209.543713688607, 22254.443638909157, 22859.19992800244, 24381.0, 24996.37509062288, 25717.614235786852, 25834.87082564575, 25847.870760646078, 19103.331383401513, 19572.21711131539, 19796.109175087444, 19799.802001980373, 19923.402297931087, 17386.826131738522, 17758.200880960645, 17817.73273400926, 18022.90988545049, 18184.908905465716, 19241.615167696847, 19922.402327930184, 19966.30117945865, 20295.4926126848, 20374.694379584616, 21469.248576299753, 21597.784022159576, 21713.565728685655, 21771.564568708854, 22009.11963521441, 18402.35591754282, 18861.622767544297, 19128.904355478135, 19159.425217243504, 19159.904200478908], "value": 12485.29788844344, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.5034162530678, 1401.1382999455334, 1419.8296204455467, 1432.4198699526696, 1441.5315022617651, 14025.158490490565, 14449.494267700633, 14660.0, 14660.633484162901, 14687.192204428753, 15128.848711512881, 15425.382984680627, 15429.151396673178, 15436.922815385935, 15454.69090618187, 2584.4572639745675, 2607.4263661994332, 2657.5083609532203, 2666.1335066103497, 2667.5065112954167, 2663.547196976509, 2690.932726681829, 2692.1923422973127, 2692.609571612115, 2693.878775455109, 2654.601809728537, 2662.4275780707144, 2662.853543055131, 2668.1595297481326, 2686.6775986881603, 2604.231751633273, 2609.1389841352498, 2640.4851054044566, 2669.119190667075, 2689.677238731355, 2641.418887844671, 2655.0839960213693, 2664.547027005414, 2664.653595032653, 2678.7053424123333, 14095.154290742588, 14313.212773297464, 14351.78472322916, 14381.78427323591, 14433.494827680981, 7474.813129671747, 7743.7676869694, 7768.223177682243, 7773.0, 7779.611019449061, 4944.473561899885, 5054.620903432257, 5126.179811230222, 5160.664556803796, 5192.169252919514, 1797.73034044893, 1801.1534578747967, 1805.5125116218678, 1809.032167790226, 1839.9540011499685, 24125.276241712778, 24258.757412425828, 24302.635460468107, 24316.513669726683, 24343.87828060866, 6283.7800676976085, 6303.747850086037, 6323.146375239284, 6578.736850525926, 6582.76960306387, 16543.0, 16550.917245413697, 16557.172141392883, 16572.337106515606, 16581.419650312182, 7628.656710448043, 7775.805604859811, 7781.41639377049, 7796.571188584682, 7799.259070388304, 7136.892946605805, 7163.7134514619875, 7184.820379490555, 7248.565086094851, 7276.126864776261, 4937.506249375106, 5191.402988656278, 5194.662346947436, 5200.843974680765, 5204.661696989683, 1547.9922600387151, 1559.7894284271479, 1569.254604063061, 1572.7404978178472, 1585.1281795012696, 815.4373482297196, 844.5481667307961, 857.8155696525278, 868.0841711993907, 875.1685898396421, 6897.7240910363025, 6956.269591692901, 6970.721171153097, 7001.334873187039, 7003.54476958996, 688.0951548713426, 691.4952084977995, 700.3941590524262, 709.1490211745926, 716.1191734166899, 4301.268784306675, 4949.455559888409, 5449.455054494598, 5461.726913654381, 5605.831825045255, 19954.102065407093, 20056.498587535138, 20581.897090514452, 20591.0, 20793.89603051975, 19585.412437626896, 19653.50866228356, 19973.101210445566, 20002.89998549998, 20469.59060818805, 10789.83815242772, 10904.945475272572, 11133.053690436403, 11160.274582152135, 11174.608888688857, 7914.0503139623615, 8239.134890836376, 8256.174382561696, 8360.581970901552, 8382.622781974704, 17089.743653844955, 17441.73837392415, 17497.30010799554, 17670.91164544169, 17756.733648995018, 17901.283948641907, 18031.729524056886, 18039.278428863225, 18143.548516118943, 18351.082445877386, 11559.884401155881, 11865.762684746429, 11867.228630139014, 11868.406579671155, 11870.228435151688, 13229.933850330686, 13240.735185296047, 13249.0, 13387.330633468093, 13425.194488330731, 10403.479826008517, 10720.785584288427, 10738.516766745359, 10825.188110891557, 10894.237403382003, 10401.058174648973, 10586.682399528027, 10687.198460115367, 10716.892831071902, 10863.456827158452, 8702.56487175626, 8820.0, 8828.470291782514, 8828.911710883065, 8841.867371989554, 6892.379685828299, 6929.653517324013, 6938.23679395256, 6951.6871740770775, 6977.2673869243, 6710.16122984627, 6745.460363170836, 6810.114685090906, 6920.688569014305, 6932.410745086522], "value": 6377.633648604429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.7934467523639, 500.9555077663072, 530.1279395394577, 530.4006472685865, 533.9893202135956, 6193.69031548423, 6338.683065846706, 6352.36376903585, 6356.841078973016, 6383.744650213992, 6132.669585557482, 6175.7529698811995, 6192.442680158785, 6197.876042479148, 6205.689715514229, 4915.778789954461, 4925.359703238574, 5007.724575148365, 5030.572401345872, 5030.974845125769, 4820.975895120519, 4882.658213925027, 4977.651564390494, 4998.40019197695, 5004.474530174334, 4867.610591152717, 4968.22992436173, 4998.850034498971, 5002.299678045077, 5003.849884503471, 4991.825286114987, 5019.673721208128, 5029.2958985742025, 5034.496550344973, 5046.419661738911, 4471.686981911267, 4472.910541789179, 4485.170243504929, 4485.730856148642, 4510.706804057726, 6122.846928826771, 6132.172156758825, 6176.0, 6182.567220294536, 6215.378462153793, 5681.375048744635, 5765.1352297155345, 5770.134479828017, 5779.422057794229, 5801.491612180821, 6424.775132870327, 6502.317256688027, 6524.445422139124, 6560.704768285439, 6606.702698378536, 4865.099956508057, 4867.9269810952865, 4872.731999740013, 4895.216765317532, 4924.3352147460355, 6883.793486195422, 6890.345417185359, 6922.826929326757, 6951.288997291061, 7039.507234493536, 4933.45731969483, 4994.40067191932, 4996.375453068366, 5016.2224855147515, 5038.546530812171, 5039.596832253411, 5043.9747801260755, 5062.949370506321, 5076.847694569169, 5137.640365174477, 5698.458646428583, 5746.195532625436, 5757.13642953552, 5759.568032397587, 5760.913586296209, 6525.282218955911, 6544.872916302125, 6584.341565843473, 6608.173978252718, 6639.2447134439635, 1645.7778199943093, 1703.4463799265288, 1719.785026871641, 1727.343609428409, 1741.7213245880598, 1189.7085214122421, 1198.1972078707288, 1200.8438902942562, 1211.2792888231663, 1220.4873952939786, 5739.741711622987, 5744.569157313218, 5769.423057694197, 5814.127880817827, 5834.212381328552, 6436.742530298736, 6550.574212676161, 6560.212774467094, 6690.4647628190605, 6747.865042699217, 5669.376368599451, 5688.8862222755315, 5721.313442386941, 5735.541156707453, 5795.971020144872, 3523.6652518010746, 3543.309054734302, 3544.3442963051402, 3566.268914872445, 3595.8245261616867, 6368.426841584187, 6393.456556192683, 6453.741850326029, 6474.384933431316, 6560.442362399154, 6791.762288319885, 6829.556078854858, 6875.828104297432, 6885.690143943534, 6929.44564434844, 6436.195475565554, 6517.348265173445, 6518.706658200393, 6519.4132528072705, 6525.21697396306, 6681.4298639818635, 6701.463882889259, 6752.662366881735, 6754.628495432602, 6802.972677158815, 6659.667016649245, 6664.0, 6674.799756007327, 6690.799276021728, 6713.832154196184, 6473.546851720523, 6479.902801457888, 6483.059956306403, 6484.962406015015, 6511.772087976898, 4941.209406494943, 4974.900501990012, 4991.3296386433085, 4996.475370086088, 5026.798928042837, 6635.7955311783635, 6702.530822842355, 6746.696398661974, 6803.319668033157, 6850.349216824394, 6418.582792118497, 6424.036394540856, 6478.805635830932, 6511.446527045254, 6546.149000629887, 6419.069234960998, 6419.582727122722, 6446.613203207822, 6497.577657452251, 6535.379138981789, 6174.351693072163, 6213.316535181217, 6337.257254255117, 6390.124444000126, 6414.583052101785, 6499.967500162658, 6523.869522609616, 6539.378759017885, 6555.672216389257, 6629.403353697998, 6287.46556542699, 6319.842003949938, 6338.841528961812, 6355.777547785805, 6377.489800815831], "value": 5049.454163312961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.5069161269694, 914.1909410171996, 915.729859691391, 918.972430827075, 924.131316562431, 18934.715979260305, 19692.21231150756, 19696.21215151396, 19705.99999999998, 19876.90061549692, 16932.4073657422, 17309.567260818487, 21052.684209736864, 21170.576588468222, 21213.469663258427, 982.2583949118424, 1049.1501883474373, 1051.7160366701025, 1056.0970370333368, 1057.4448414582366, 965.555844311614, 1062.8883967183451, 1068.038765111402, 1068.6687126990619, 1071.223363061778, 1127.3179726265573, 1131.564347726123, 1133.48992953171, 1135.1316243074054, 1135.4833550734395, 1111.3443068589531, 1115.9218854680175, 1116.0346300450133, 1116.2019156303281, 1117.290520519472, 812.715549557656, 815.1807433529324, 815.3029160068115, 815.6125840225905, 816.3428440105713, 20163.495912602157, 20366.389008329774, 20367.49081272965, 20508.897455512775, 21022.474438139016, 21013.47466313339, 21413.35759927189, 21523.46191345213, 21823.67264491034, 22523.436914077116, 17026.489205323862, 17032.829671703374, 17146.056966866818, 17205.139743012925, 17325.306987720604, 3619.69232615228, 3647.416413373874, 3648.872289469856, 3650.1969566695284, 3651.214988777399, 122288.38855805664, 134002.0, 134023.0, 134520.3273983624, 138788.30605846905, 17936.730949035777, 18016.189271482814, 18384.0, 18490.260389584535, 18532.536686582942, 31860.522092168638, 32126.0, 32135.357292854012, 32276.0, 32728.836355818068, 8574.442661227, 8698.304135669132, 8758.036615972238, 8778.078301778349, 8827.823443531093, 4050.7974601270407, 4080.571539988318, 4109.465769449952, 4133.297339452301, 4147.854825081107, 5015.573676237488, 5092.439831618519, 5098.1842905135, 5132.1788513838355, 5140.151874940593, 1032.865727455441, 1040.3393844908537, 1045.430240518919, 1049.165913099073, 1049.9265051446325, 670.735059651435, 687.4431710314661, 689.2005273882272, 697.6476879175983, 710.9939435698532, 11240.662780116609, 11671.241369310968, 13345.532906348231, 13390.0, 13590.864091359157, 617.586217234454, 623.6788054152115, 643.7585905285518, 647.795944277551, 678.4097834883682, 5390.703511306838, 5411.56707463402, 5455.236266922634, 5622.887542249214, 5719.799807006735, 106657.0, 109881.0, 109948.0, 111338.44330778456, 113465.0, 97953.0, 97983.51008244914, 98163.50918245364, 99541.0, 99614.0, 83672.58163709143, 85134.57432712796, 85192.57403713066, 85308.14691853126, 86104.0, 10201.74495637615, 10324.741881453023, 10358.637447689294, 10371.429571373646, 10556.472176390997, 39612.0, 39637.80181099076, 39877.60122398739, 41406.171876562905, 41940.161196776506, 71662.64168679123, 71995.0, 72400.0, 73935.0, 75223.62388188243, 18658.720119198493, 18667.813321866608, 19028.619427611648, 19662.410127696192, 19726.50683732861, 20897.37307880766, 21382.893085534473, 21462.892685536473, 21515.569688606454, 21726.0, 16874.240659170613, 17355.56611084733, 18280.177392017657, 18290.35983740616, 18302.633947321247, 16245.675086497968, 16293.266802993656, 16856.410025649042, 16857.409990650267, 17003.0, 17160.828391715924, 17471.0, 17987.820121799137, 18071.819281807013, 18247.81752182461, 12511.0, 12766.936165319114, 12769.744605108031, 12916.677083072998, 13087.887529560094, 14212.928935355258, 14337.498187563386, 14626.367253894401, 14692.045017073857, 14843.257837107885], "value": 9237.451510825294, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 103.0, 107.0, 107.0, 111.0, 108.0, 103.0, 114.0, 109.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 149.0, 184.0, 135.0, 145.0, 153.0, 119.0, 175.0, 121.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 162.0, 162.0, 164.0, 163.0, 171.0, 166.0, 164.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 172.0, 80.0, 86.0, 74.0, 74.0, 161.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 78.0, 125.0, 82.0, 79.0, 87.0, 135.0, 80.0, 79.0, 155.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 114.0, 114.0, 121.0, 114.0, 114.0, 114.0, 117.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 150.0, 149.0, 149.0, 151.0, 151.0, 150.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 57.0, 56.0, 54.0, 58.0, 55.0, 54.0, 53.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 55.0, 54.0, 54.0, 54.0, 54.0, 61.0, 55.0, 60.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 80.0, 73.0, 75.0, 79.0, 77.0, 74.0, 77.0, 79.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 130.0, 137.0, 118.0, 118.0, 137.0, 126.0, 122.0, 163.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 182.0, 183.0, 173.0, 175.0, 174.0, 178.0, 175.0, 177.0, 170.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 77.0, 68.0, 67.0, 66.0, 65.0, 64.0, 67.0, 68.0], "value": 67.8, "unit": "score"}]}]} 11:19:19 INFO - Return code: 0 11:19:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:19 INFO - # TBPL SUCCESS # 11:19:19 INFO - Running post-action listener: _package_coverage_data 11:19:19 INFO - Running post-action listener: _resource_record_post_action 11:19:19 INFO - [mozharness: 2017-08-21 18:19:19.119794Z] Finished run-tests step (success) 11:19:19 INFO - Running post-run listener: _resource_record_post_run 11:19:19 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5730304; Write bytes: 444891136; Read time: 3456; Write time: 422040 11:19:19 INFO - TinderboxPrint: CPU usage
13.2% 11:19:19 INFO - TinderboxPrint: I/O read bytes / time
5,730,304 / 3,456 11:19:19 INFO - TinderboxPrint: I/O write bytes / time
444,891,136 / 422,040 11:19:19 INFO - TinderboxPrint: CPU idle
8,279.3 (86.8%) 11:19:19 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 11:19:19 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 122880; Write bytes: 156815360; Read time: 480; Write time: 90672 11:19:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:19:19 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3575808; Write bytes: 221356032; Read time: 2624; Write time: 239012 11:19:19 INFO - Running post-run listener: _upload_blobber_files 11:19:19 INFO - Blob upload gear active. 11:19:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:19 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 11:19:19 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'] 11:19:19 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 11:19:20 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:19:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:26 INFO - (blobuploader) - INFO - Done attempting. 11:19:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:19:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:19:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:27 INFO - (blobuploader) - INFO - Done attempting. 11:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:28 INFO - (blobuploader) - INFO - Done attempting. 11:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:29 INFO - (blobuploader) - INFO - Done attempting. 11:19:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:19:29 INFO - Return code: 0 11:19:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:19:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:19:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60ab05fb587610f8ff31b68783e4075ed508bac4ac773c052f21cd227b10cc109878f282eabacc0bc289f2fdc49e188dd921a4f3502cd98a0866ba9251064a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bab3ab44efe831a89ed17aa565fed5a13682919c49a994e687a9afe3ca67e35e405f329f20dcbe05b3e117da8a79eac2dfff4165056da7ecd1e38e3bb427f89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/559f80d0e298154ae7dc76e52e211e10d8c577654f8c41f0ab919a8995f004e3dd3c63d899e4dac7b116ce3dafc5b8fec76c41d5205ea19d7a185119bbe5792e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7292af8f147972bd89daa8b08665054e7569b18c6bbe0f4e1b25fe43536406833c9ae4716b2dd737278c410385eb9a6655de9cc72253ca0e3b2f7c7ed50324"} 11:19:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:19:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:19:29 INFO - Contents: 11:19:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60ab05fb587610f8ff31b68783e4075ed508bac4ac773c052f21cd227b10cc109878f282eabacc0bc289f2fdc49e188dd921a4f3502cd98a0866ba9251064a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bab3ab44efe831a89ed17aa565fed5a13682919c49a994e687a9afe3ca67e35e405f329f20dcbe05b3e117da8a79eac2dfff4165056da7ecd1e38e3bb427f89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/559f80d0e298154ae7dc76e52e211e10d8c577654f8c41f0ab919a8995f004e3dd3c63d899e4dac7b116ce3dafc5b8fec76c41d5205ea19d7a185119bbe5792e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7292af8f147972bd89daa8b08665054e7569b18c6bbe0f4e1b25fe43536406833c9ae4716b2dd737278c410385eb9a6655de9cc72253ca0e3b2f7c7ed50324"} 11:19:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:19:29 INFO - Copying logs to upload dir... 11:19:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:19:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.638372 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-21 11:19:29.316305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:29.319923) ========= 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=31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60ab05fb587610f8ff31b68783e4075ed508bac4ac773c052f21cd227b10cc109878f282eabacc0bc289f2fdc49e188dd921a4f3502cd98a0866ba9251064a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bab3ab44efe831a89ed17aa565fed5a13682919c49a994e687a9afe3ca67e35e405f329f20dcbe05b3e117da8a79eac2dfff4165056da7ecd1e38e3bb427f89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/559f80d0e298154ae7dc76e52e211e10d8c577654f8c41f0ab919a8995f004e3dd3c63d899e4dac7b116ce3dafc5b8fec76c41d5205ea19d7a185119bbe5792e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7292af8f147972bd89daa8b08665054e7569b18c6bbe0f4e1b25fe43536406833c9ae4716b2dd737278c410385eb9a6655de9cc72253ca0e3b2f7c7ed50324"} build_url:https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60ab05fb587610f8ff31b68783e4075ed508bac4ac773c052f21cd227b10cc109878f282eabacc0bc289f2fdc49e188dd921a4f3502cd98a0866ba9251064a93", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8bab3ab44efe831a89ed17aa565fed5a13682919c49a994e687a9afe3ca67e35e405f329f20dcbe05b3e117da8a79eac2dfff4165056da7ecd1e38e3bb427f89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/559f80d0e298154ae7dc76e52e211e10d8c577654f8c41f0ab919a8995f004e3dd3c63d899e4dac7b116ce3dafc5b8fec76c41d5205ea19d7a185119bbe5792e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c7292af8f147972bd89daa8b08665054e7569b18c6bbe0f4e1b25fe43536406833c9ae4716b2dd737278c410385eb9a6655de9cc72253ca0e3b2f7c7ed50324"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:29.346593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:29.346889) ========= 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=31acecf42b6a79ec49471d4a000001bb-1503334740.311510-1001196468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004746 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:29.431685) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 11:19:29.431991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 11:19:29.432494) ========= ========= Total master_lag: 0.19 =========