builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1504036214.53 results: success (0) revision: 6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.526162) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.526631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.526928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.543327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.543675) ========= 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=4300f881736b422476174874000001bc-1504036214.23745-602349572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-29 12:50:14-- 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% 37.9M=0s 2017-08-29 12:50:14 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103293 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.662308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.662641) ========= 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=4300f881736b422476174874000001bc-1504036214.23745-602349572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.712965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:14.713309) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4 --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 6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4 --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=4300f881736b422476174874000001bc-1504036214.23745-602349572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-29 12:50:14,925 truncating revision to first 12 chars 2017-08-29 12:50:14,925 Setting DEBUG logging. 2017-08-29 12:50:14,925 attempt 1/10 2017-08-29 12:50:14,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6c3510bac832?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-29 12:50:15,376 unpacking tar archive at: mozilla-central-6c3510bac832/testing/mozharness/ program finished with exit code 0 elapsedTime=0.750405 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:15.478682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:15.479031) ========= script_repo_revision: 6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:15.479419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:15.479689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-29 12:50:15.490410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-29 12:50:15.490720) ========= /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=4300f881736b422476174874000001bc-1504036214.23745-602349572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:15 INFO - MultiFileLogger online at 20170829 12:50:15 in /builds/slave/test 12:50:15 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 12:50:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:15 INFO - {'append_to_log': False, 12:50:15 INFO - 'base_work_dir': '/builds/slave/test', 12:50:15 INFO - 'blob_upload_branch': 'Firefox', 12:50:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:15 INFO - 'branch': 'Firefox', 12:50:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:15 INFO - 'code_coverage': False, 12:50:15 INFO - 'config_files': ('talos/linux_config.py',), 12:50:15 INFO - 'default_actions': ('clobber', 12:50:15 INFO - 'read-buildbot-config', 12:50:15 INFO - 'download-and-extract', 12:50:15 INFO - 'populate-webroot', 12:50:15 INFO - 'create-virtualenv', 12:50:15 INFO - 'install', 12:50:15 INFO - 'setup-mitmproxy', 12:50:15 INFO - 'run-tests'), 12:50:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:15 INFO - 'disable_ccov_upload': False, 12:50:15 INFO - 'disable_stylo': False, 12:50:15 INFO - 'download_minidump_stackwalk': True, 12:50:15 INFO - 'download_symbols': 'ondemand', 12:50:15 INFO - 'enable_stylo': False, 12:50:15 INFO - 'enable_webrender': False, 12:50:15 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:50:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:15 INFO - 'gecko_profile': False, 12:50:15 INFO - 'gecko_profile_interval': 0, 12:50:15 INFO - 'installer_path': 'installer.exe', 12:50:15 INFO - 'log_level': 'info', 12:50:15 INFO - 'log_name': 'talos', 12:50:15 INFO - 'log_to_console': True, 12:50:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:15 INFO - 'opt_config_files': (), 12:50:15 INFO - 'pip_index': False, 12:50:15 INFO - 'suite': 'dromaeojs-e10s', 12:50:15 INFO - 'system_bits': '32', 12:50:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:15 INFO - 'title': 'talos-linux64-ix-045', 12:50:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:15 INFO - 'use_talos_json': True, 12:50:15 INFO - 'verify': 'False', 12:50:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:15 INFO - 'work_dir': 'build'} 12:50:15 INFO - [mozharness: 2017-08-29 19:50:15.849086Z] Running clobber step. 12:50:15 INFO - Running pre-action listener: _resource_record_pre_action 12:50:15 INFO - Running main action method: clobber 12:50:15 INFO - rmtree: /builds/slave/test/build 12:50:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:16 INFO - Running post-action listener: _resource_record_post_action 12:50:16 INFO - [mozharness: 2017-08-29 19:50:16.861625Z] Finished clobber step (success) 12:50:16 INFO - [mozharness: 2017-08-29 19:50:16.861722Z] Running read-buildbot-config step. 12:50:16 INFO - Running pre-action listener: _resource_record_pre_action 12:50:16 INFO - Running main action method: read_buildbot_config 12:50:16 INFO - Using buildbot properties: 12:50:16 INFO - { 12:50:16 INFO - "project": "", 12:50:16 INFO - "product": "firefox", 12:50:16 INFO - "who": "archaeopteryx@coole-files.de", 12:50:16 INFO - "installer_path": "public/build/target.tar.bz2", 12:50:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:50:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:50:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 12:50:16 INFO - "stage_platform": "linux64-pgo", 12:50:16 INFO - "basedir": "/builds/slave/test", 12:50:16 INFO - "buildnumber": 146, 12:50:16 INFO - "platform": "ubuntu64_hw", 12:50:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:50:16 INFO - "slavebuilddir": "test", 12:50:16 INFO - "taskId": "ZfTkaFQDQr2-5xDXPWFgcw", 12:50:16 INFO - "branch": "mozilla-central", 12:50:16 INFO - "script_repo_revision": "production", 12:50:16 INFO - "revision": "6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4", 12:50:16 INFO - "slavename": "talos-linux64-ix-045", 12:50:16 INFO - "repo_path": "mozilla-central" 12:50:16 INFO - } 12:50:16 INFO - Finding installer, test and symbols from parent task. 12:50:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZfTkaFQDQr2-5xDXPWFgcw'}, attempt #1 12:50:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZfTkaFQDQr2-5xDXPWFgcw'}, attempt #1 12:50:17 INFO - Task dependencies: c5iznR3nTS6fHhaEfhjVAw 12:50:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw'}, attempt #1 12:50:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2 12:50:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.test_packages.json 12:50:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.crashreporter-symbols.zip 12:50:18 INFO - Running post-action listener: _resource_record_post_action 12:50:18 INFO - [mozharness: 2017-08-29 19:50:18.228616Z] Finished read-buildbot-config step (success) 12:50:18 INFO - [mozharness: 2017-08-29 19:50:18.228837Z] Running download-and-extract step. 12:50:18 INFO - Running pre-action listener: _resource_record_pre_action 12:50:18 INFO - Running main action method: download_and_extract 12:50:18 INFO - mkdir: /builds/slave/test/build/tests 12:50:18 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')]} 12:50:18 INFO - trying https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.test_packages.json 12:50:18 INFO - Downloading https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:50:18 INFO - Downloaded 989 bytes. 12:50:18 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:50:18 INFO - Using the following test package requirements: 12:50:18 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:50:18 INFO - u'common': [u'target.common.tests.zip'], 12:50:18 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:50:18 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:50:18 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:50:18 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:50:18 INFO - u'mozbase': [u'target.common.tests.zip'], 12:50:18 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:50:18 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:50:18 INFO - u'web-platform': [u'target.common.tests.zip', 12:50:18 INFO - u'target.web-platform.tests.tar.gz'], 12:50:18 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:50:18 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:50:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.common.tests.zip 12:50:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:50:18 INFO - Fetch https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.common.tests.zip into memory 12:50:20 INFO - Content-Length response header: 55608915 12:50:20 INFO - Bytes received: 55608915 12:50:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:50:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.common.tests.zip 12:50:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:50:31 INFO - Fetch https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.common.tests.zip into memory 12:50:32 INFO - Content-Length response header: 55608915 12:50:32 INFO - Bytes received: 55608915 12:50:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.talos.tests.zip 12:50:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:50:45 INFO - Fetch https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.talos.tests.zip into memory 12:50:45 INFO - Content-Length response header: 14496610 12:50:45 INFO - Bytes received: 14496610 12:50:46 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')]} 12:50:46 INFO - trying https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2 12:50:46 INFO - Downloading https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:50:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:50:47 INFO - Downloaded 63328351 bytes. 12:50:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2 12:50:47 INFO - mkdir: /builds/slave/test/properties 12:50:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:50:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:50:47 INFO - Contents: 12:50:47 INFO - build_url:https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2 12:50:47 INFO - Running post-action listener: _resource_record_post_action 12:50:47 INFO - Running post-action listener: find_tests_for_verification 12:50:47 INFO - Running post-action listener: set_extra_try_arguments 12:50:47 INFO - [mozharness: 2017-08-29 19:50:47.373108Z] Finished download-and-extract step (success) 12:50:47 INFO - [mozharness: 2017-08-29 19:50:47.373204Z] Running populate-webroot step. 12:50:47 INFO - Running pre-action listener: _resource_record_pre_action 12:50:47 INFO - Running main action method: populate_webroot 12:50:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:50:47 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:50:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:50:47 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:50:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:47 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:50:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'tests': ['damp', 'tps']}, 12:50:47 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['damp', 'tps']}, 12:50:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:50:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:50:47 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:50:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:50:47 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:50:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:50:47 INFO - 'ts_paint', 12:50:47 INFO - 'tpaint', 12:50:47 INFO - 'sessionrestore', 12:50:47 INFO - 'sessionrestore_many_windows', 12:50:47 INFO - 'sessionrestore_no_auto_restore', 12:50:47 INFO - 'tabpaint']}, 12:50:47 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['a11yr', 12:50:47 INFO - 'ts_paint', 12:50:47 INFO - 'tpaint', 12:50:47 INFO - 'sessionrestore', 12:50:47 INFO - 'sessionrestore_many_windows', 12:50:47 INFO - 'sessionrestore_no_auto_restore', 12:50:47 INFO - 'tabpaint']}, 12:50:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 12:50:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 12:50:47 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['bloom_basic_singleton']}, 12:50:47 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['bloom_basic']}, 12:50:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:50:47 INFO - 'tsvgr_opacity', 12:50:47 INFO - 'tart', 12:50:47 INFO - 'tscrollx', 12:50:47 INFO - 'tsvg_static']}, 12:50:47 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['tsvgx', 12:50:47 INFO - 'tsvgr_opacity', 12:50:47 INFO - 'tart', 12:50:47 INFO - 'tscrollx', 12:50:47 INFO - 'tsvg_static']}, 12:50:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:50:47 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo'], 12:50:47 INFO - 'tests': ['tp5o']}, 12:50:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:50:47 INFO - 'talos_options': ['--mitmproxy', 12:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:50:47 INFO - '--firstNonBlankPaint'], 12:50:47 INFO - 'tests': ['tp6_google', 12:50:47 INFO - 'tp6_youtube', 12:50:47 INFO - 'tp6_amazon', 12:50:47 INFO - 'tp6_facebook']}, 12:50:47 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo', 12:50:47 INFO - '--mitmproxy', 12:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:50:47 INFO - '--firstNonBlankPaint'], 12:50:47 INFO - 'tests': ['tp6_google', 12:50:47 INFO - 'tp6_youtube', 12:50:47 INFO - 'tp6_amazon', 12:50:47 INFO - 'tp6_facebook']}, 12:50:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo', 12:50:47 INFO - '--stylo-threads=1', 12:50:47 INFO - '--mitmproxy', 12:50:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:50:47 INFO - '--firstNonBlankPaint'], 12:50:47 INFO - 'tests': ['tp6_google', 12:50:47 INFO - 'tp6_youtube', 12:50:47 INFO - 'tp6_amazon', 12:50:47 INFO - 'tp6_facebook']}, 12:50:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--xperf_path', 12:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:47 INFO - 'tests': ['tp5n']}, 12:50:47 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 12:50:47 INFO - 'talos_options': ['--enable-stylo', 12:50:47 INFO - '--xperf_path', 12:50:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:50:47 INFO - 'tests': ['tp5n']}}} 12:50:47 INFO - Running post-action listener: _resource_record_post_action 12:50:47 INFO - [mozharness: 2017-08-29 19:50:47.387616Z] Finished populate-webroot step (success) 12:50:47 INFO - [mozharness: 2017-08-29 19:50:47.387705Z] Running create-virtualenv step. 12:50:47 INFO - Running pre-action listener: _resource_record_pre_action 12:50:47 INFO - Running main action method: create_virtualenv 12:50:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:50:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:50:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:50:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:50:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:50:48 INFO - Installing pip...............done. 12:50:48 INFO - Return code: 0 12:50:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:50:48 INFO - Reading from file tmpfile_stdout 12:50:48 INFO - Output received: 12:50:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:50:48 INFO - Using env: {'DISPLAY': ':0', 12:50:48 INFO - 'HOME': '/home/cltbld', 12:50:48 INFO - 'LANG': 'en_US.UTF-8', 12:50:48 INFO - 'LANGUAGE': 'en_US:en', 12:50:48 INFO - 'LOGNAME': 'cltbld', 12:50:48 INFO - 'MAIL': '/var/mail/cltbld', 12:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:48 INFO - 'MOZ_NO_REMOTE': '1', 12:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:48 INFO - 'NO_EM_RESTART': '1', 12:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:48 INFO - 'PWD': '/builds/slave/test', 12:50:48 INFO - 'SHELL': '/bin/bash', 12:50:48 INFO - 'SHLVL': '1', 12:50:48 INFO - 'TERM': 'linux', 12:50:48 INFO - 'TMOUT': '86400', 12:50:48 INFO - 'USER': 'cltbld', 12:50:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:48 INFO - '_': '/tools/buildbot/bin/python'} 12:50:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:50:49 INFO - Downloading/unpacking pip>=1.5 12:50:49 INFO - Running setup.py egg_info for package pip 12:50:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:50:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:50:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:50:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:50:49 INFO - Installing collected packages: pip 12:50:49 INFO - Found existing installation: pip 1.1 12:50:49 INFO - Uninstalling pip: 12:50:49 INFO - Successfully uninstalled pip 12:50:49 INFO - Running setup.py install for pip 12:50:49 INFO - warning: no files found matching 'pip/cacert.pem' 12:50:49 INFO - warning: no files found matching '*.html' under directory 'docs' 12:50:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:50:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:50:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:50:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:50:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:50:49 INFO - Successfully installed pip 12:50:49 INFO - Cleaning up... 12:50:49 INFO - Return code: 0 12:50:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:50:49 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')]} 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:49 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')]} 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:49 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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:49 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 12:50:49 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 12:50:49 INFO - Using env: {'DISPLAY': ':0', 12:50:49 INFO - 'HOME': '/home/cltbld', 12:50:49 INFO - 'LANG': 'en_US.UTF-8', 12:50:49 INFO - 'LANGUAGE': 'en_US:en', 12:50:49 INFO - 'LOGNAME': 'cltbld', 12:50:49 INFO - 'MAIL': '/var/mail/cltbld', 12:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:49 INFO - 'MOZ_NO_REMOTE': '1', 12:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:49 INFO - 'NO_EM_RESTART': '1', 12:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:49 INFO - 'PWD': '/builds/slave/test', 12:50:49 INFO - 'SHELL': '/bin/bash', 12:50:49 INFO - 'SHLVL': '1', 12:50:49 INFO - 'TERM': 'linux', 12:50:49 INFO - 'TMOUT': '86400', 12:50:49 INFO - 'USER': 'cltbld', 12:50:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:49 INFO - '_': '/tools/buildbot/bin/python'} 12:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:49 INFO - Downloading/unpacking psutil>=3.1.1 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:51 INFO - Installing collected packages: psutil 12:50:51 INFO - Running setup.py install for psutil 12:50:51 INFO - building 'psutil._psutil_linux' extension 12:50:51 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 12:50:51 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 12:50:51 INFO - building 'psutil._psutil_posix' extension 12:50:51 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 12:50:51 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 12:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:50:51 INFO - Successfully installed psutil 12:50:51 INFO - Cleaning up... 12:50:51 INFO - Return code: 0 12:50:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:50:51 INFO - Using env: {'DISPLAY': ':0', 12:50:51 INFO - 'HOME': '/home/cltbld', 12:50:51 INFO - 'LANG': 'en_US.UTF-8', 12:50:51 INFO - 'LANGUAGE': 'en_US:en', 12:50:51 INFO - 'LOGNAME': 'cltbld', 12:50:51 INFO - 'MAIL': '/var/mail/cltbld', 12:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:51 INFO - 'MOZ_NO_REMOTE': '1', 12:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:51 INFO - 'NO_EM_RESTART': '1', 12:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:51 INFO - 'PWD': '/builds/slave/test', 12:50:51 INFO - 'SHELL': '/bin/bash', 12:50:51 INFO - 'SHLVL': '1', 12:50:51 INFO - 'TERM': 'linux', 12:50:51 INFO - 'TMOUT': '86400', 12:50:51 INFO - 'USER': 'cltbld', 12:50:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:51 INFO - '_': '/tools/buildbot/bin/python'} 12:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:50:52 INFO - Installing collected packages: mozsystemmonitor 12:50:52 INFO - Running setup.py install for mozsystemmonitor 12:50:53 INFO - Successfully installed mozsystemmonitor 12:50:53 INFO - Cleaning up... 12:50:53 INFO - Return code: 0 12:50:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:50:53 INFO - Using env: {'DISPLAY': ':0', 12:50:53 INFO - 'HOME': '/home/cltbld', 12:50:53 INFO - 'LANG': 'en_US.UTF-8', 12:50:53 INFO - 'LANGUAGE': 'en_US:en', 12:50:53 INFO - 'LOGNAME': 'cltbld', 12:50:53 INFO - 'MAIL': '/var/mail/cltbld', 12:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:53 INFO - 'MOZ_NO_REMOTE': '1', 12:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:53 INFO - 'NO_EM_RESTART': '1', 12:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:53 INFO - 'PWD': '/builds/slave/test', 12:50:53 INFO - 'SHELL': '/bin/bash', 12:50:53 INFO - 'SHLVL': '1', 12:50:53 INFO - 'TERM': 'linux', 12:50:53 INFO - 'TMOUT': '86400', 12:50:53 INFO - 'USER': 'cltbld', 12:50:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:53 INFO - '_': '/tools/buildbot/bin/python'} 12:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:50:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:50:54 INFO - warning: no files found matching '*.txt' 12:50:54 INFO - no previously-included directories found matching 'build' 12:50:54 INFO - no previously-included directories found matching 'dist' 12:50:54 INFO - no previously-included directories found matching '.git*' 12:50:54 INFO - Installing collected packages: jsonschema, functools32 12:50:54 INFO - Running setup.py install for functools32 12:50:54 INFO - warning: no files found matching '*.txt' 12:50:54 INFO - no previously-included directories found matching 'build' 12:50:54 INFO - no previously-included directories found matching 'dist' 12:50:54 INFO - no previously-included directories found matching '.git*' 12:50:54 INFO - Successfully installed jsonschema functools32 12:50:54 INFO - Cleaning up... 12:50:54 INFO - Return code: 0 12:50:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:50:54 INFO - Using env: {'DISPLAY': ':0', 12:50:54 INFO - 'HOME': '/home/cltbld', 12:50:54 INFO - 'LANG': 'en_US.UTF-8', 12:50:54 INFO - 'LANGUAGE': 'en_US:en', 12:50:54 INFO - 'LOGNAME': 'cltbld', 12:50:54 INFO - 'MAIL': '/var/mail/cltbld', 12:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:54 INFO - 'MOZ_NO_REMOTE': '1', 12:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:54 INFO - 'NO_EM_RESTART': '1', 12:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:54 INFO - 'PWD': '/builds/slave/test', 12:50:54 INFO - 'SHELL': '/bin/bash', 12:50:54 INFO - 'SHLVL': '1', 12:50:54 INFO - 'TERM': 'linux', 12:50:54 INFO - 'TMOUT': '86400', 12:50:54 INFO - 'USER': 'cltbld', 12:50:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:54 INFO - '_': '/tools/buildbot/bin/python'} 12:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:50:54 INFO - Cleaning up... 12:50:54 INFO - Return code: 0 12:50:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:50:54 INFO - Using env: {'DISPLAY': ':0', 12:50:54 INFO - 'HOME': '/home/cltbld', 12:50:54 INFO - 'LANG': 'en_US.UTF-8', 12:50:54 INFO - 'LANGUAGE': 'en_US:en', 12:50:54 INFO - 'LOGNAME': 'cltbld', 12:50:54 INFO - 'MAIL': '/var/mail/cltbld', 12:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:54 INFO - 'MOZ_NO_REMOTE': '1', 12:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:54 INFO - 'NO_EM_RESTART': '1', 12:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:54 INFO - 'PWD': '/builds/slave/test', 12:50:54 INFO - 'SHELL': '/bin/bash', 12:50:54 INFO - 'SHLVL': '1', 12:50:54 INFO - 'TERM': 'linux', 12:50:54 INFO - 'TMOUT': '86400', 12:50:54 INFO - 'USER': 'cltbld', 12:50:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:54 INFO - '_': '/tools/buildbot/bin/python'} 12:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:50:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:50:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:50:56 INFO - Downloading docopt-0.6.1.tar.gz 12:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:50:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:50:56 INFO - Running setup.py install for blobuploader 12:50:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:50:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:50:56 INFO - Running setup.py install for requests 12:50:57 INFO - Running setup.py install for docopt 12:50:57 INFO - Successfully installed blobuploader requests docopt 12:50:57 INFO - Cleaning up... 12:50:57 INFO - Return code: 0 12:50:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:50:57 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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:50:57 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 12:50:57 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 12:50:57 INFO - Using env: {'DISPLAY': ':0', 12:50:57 INFO - 'HOME': '/home/cltbld', 12:50:57 INFO - 'LANG': 'en_US.UTF-8', 12:50:57 INFO - 'LANGUAGE': 'en_US:en', 12:50:57 INFO - 'LOGNAME': 'cltbld', 12:50:57 INFO - 'MAIL': '/var/mail/cltbld', 12:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:57 INFO - 'MOZ_NO_REMOTE': '1', 12:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:57 INFO - 'NO_EM_RESTART': '1', 12:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:57 INFO - 'PWD': '/builds/slave/test', 12:50:57 INFO - 'SHELL': '/bin/bash', 12:50:57 INFO - 'SHLVL': '1', 12:50:57 INFO - 'TERM': 'linux', 12:50:57 INFO - 'TMOUT': '86400', 12:50:57 INFO - 'USER': 'cltbld', 12:50:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:57 INFO - '_': '/tools/buildbot/bin/python'} 12:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:50:57 INFO - Running setup.py (path:/tmp/pip-BjuRLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:50:57 INFO - Running setup.py (path:/tmp/pip-bDNUyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:50:57 INFO - Running setup.py (path:/tmp/pip-iz1Kqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:50:57 INFO - Running setup.py (path:/tmp/pip-ATsieH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:50:57 INFO - Running setup.py (path:/tmp/pip-MAbDxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:50:58 INFO - Running setup.py (path:/tmp/pip-a6COjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:50:58 INFO - Running setup.py (path:/tmp/pip-UxCEN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:50:58 INFO - Running setup.py (path:/tmp/pip-IBYIul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:50:58 INFO - Running setup.py (path:/tmp/pip-E4ZADI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:50:58 INFO - Running setup.py (path:/tmp/pip-dVLxGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:50:58 INFO - Running setup.py (path:/tmp/pip-vYryU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:50:58 INFO - Running setup.py (path:/tmp/pip-icMDVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:50:58 INFO - Running setup.py (path:/tmp/pip-nGka43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:50:58 INFO - Running setup.py (path:/tmp/pip-cSMRrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:58 INFO - Running setup.py (path:/tmp/pip-YZnfRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:50:58 INFO - Running setup.py (path:/tmp/pip-79xqXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:50:58 INFO - Running setup.py (path:/tmp/pip-C5ASP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:50:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:50:58 INFO - Running setup.py install for manifestparser 12:50:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:50:58 INFO - Running setup.py install for mozcrash 12:50:59 INFO - Running setup.py install for mozdebug 12:50:59 INFO - Running setup.py install for mozdevice 12:50:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozfile 12:50:59 INFO - Running setup.py install for mozhttpd 12:50:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozinfo 12:50:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozInstall 12:50:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozleak 12:50:59 INFO - Running setup.py install for mozlog 12:50:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for moznetwork 12:50:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:50:59 INFO - Running setup.py install for mozprocess 12:51:00 INFO - Running setup.py install for mozprofile 12:51:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozrunner 12:51:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Running setup.py install for mozscreenshot 12:51:00 INFO - Running setup.py install for moztest 12:51:00 INFO - Running setup.py install for mozversion 12:51:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:51:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:51:00 INFO - Cleaning up... 12:51:00 INFO - Return code: 0 12:51:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:00 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')]} 12:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:00 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')]} 12:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:00 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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:51:00 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 12:51:00 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 12:51:00 INFO - Using env: {'DISPLAY': ':0', 12:51:00 INFO - 'HOME': '/home/cltbld', 12:51:00 INFO - 'LANG': 'en_US.UTF-8', 12:51:00 INFO - 'LANGUAGE': 'en_US:en', 12:51:00 INFO - 'LOGNAME': 'cltbld', 12:51:00 INFO - 'MAIL': '/var/mail/cltbld', 12:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:00 INFO - 'MOZ_NO_REMOTE': '1', 12:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:00 INFO - 'NO_EM_RESTART': '1', 12:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:00 INFO - 'PWD': '/builds/slave/test', 12:51:00 INFO - 'SHELL': '/bin/bash', 12:51:00 INFO - 'SHLVL': '1', 12:51:00 INFO - 'TERM': 'linux', 12:51:00 INFO - 'TMOUT': '86400', 12:51:00 INFO - 'USER': 'cltbld', 12:51:00 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:00 INFO - '_': '/tools/buildbot/bin/python'} 12:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:51:00 INFO - Running setup.py (path:/tmp/pip-Fvlnzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:51:00 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)) 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:51:00 INFO - Running setup.py (path:/tmp/pip-it38T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:51:00 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)) 12:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:51:00 INFO - Running setup.py (path:/tmp/pip-w2M7Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:51:01 INFO - Running setup.py (path:/tmp/pip-t4Mgse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:51:01 INFO - Running setup.py (path:/tmp/pip-3IsvbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:51:01 INFO - Running setup.py (path:/tmp/pip-jzzTAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:51:01 INFO - Running setup.py (path:/tmp/pip-CrO_vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:51:01 INFO - Running setup.py (path:/tmp/pip-tIDogy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:51:01 INFO - Running setup.py (path:/tmp/pip-1Wdcgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:51:01 INFO - Running setup.py (path:/tmp/pip-1jMeOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:51:01 INFO - Running setup.py (path:/tmp/pip-xpJAfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:51:01 INFO - Running setup.py (path:/tmp/pip-1IwPvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:51:01 INFO - Running setup.py (path:/tmp/pip-5hMJyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:51:01 INFO - Running setup.py (path:/tmp/pip-fulPMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:01 INFO - Running setup.py (path:/tmp/pip-pZHA6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:51:01 INFO - Running setup.py (path:/tmp/pip-dZN1J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:51:01 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)) 12:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:51:01 INFO - Running setup.py (path:/tmp/pip-5Mo8oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 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)) 12:51:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:51:02 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 12:51:02 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 12:51:02 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 12:51:02 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 12:51:03 INFO - Downloading blessings-1.6.tar.gz 12:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:51:03 INFO - Installing collected packages: blessings 12:51:03 INFO - Running setup.py install for blessings 12:51:03 INFO - Successfully installed blessings 12:51:03 INFO - Cleaning up... 12:51:03 INFO - Return code: 0 12:51:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:51:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:03 INFO - Reading from file tmpfile_stdout 12:51:03 INFO - Current package versions: 12:51:03 INFO - argparse == 1.2.1 12:51:03 INFO - blessings == 1.6 12:51:03 INFO - blobuploader == 1.2.4 12:51:03 INFO - docopt == 0.6.1 12:51:03 INFO - functools32 == 3.2.3-2 12:51:03 INFO - jsonschema == 2.5.1 12:51:03 INFO - manifestparser == 1.1 12:51:03 INFO - mozInstall == 1.13 12:51:03 INFO - mozcrash == 1.0 12:51:03 INFO - mozdebug == 0.1 12:51:03 INFO - mozdevice == 0.51 12:51:03 INFO - mozfile == 1.2 12:51:03 INFO - mozhttpd == 0.7 12:51:03 INFO - mozinfo == 0.10 12:51:03 INFO - mozleak == 0.1 12:51:03 INFO - mozlog == 3.5 12:51:03 INFO - moznetwork == 0.27 12:51:03 INFO - mozprocess == 0.25 12:51:03 INFO - mozprofile == 0.28 12:51:03 INFO - mozrunner == 6.13 12:51:03 INFO - mozscreenshot == 0.1 12:51:03 INFO - mozsystemmonitor == 0.3 12:51:03 INFO - moztest == 0.8 12:51:03 INFO - mozversion == 1.4 12:51:03 INFO - psutil == 3.1.1 12:51:03 INFO - requests == 1.2.3 12:51:03 INFO - wsgiref == 0.1.2 12:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:51:03 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')]} 12:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:03 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')]} 12:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:03 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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:51:03 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 12:51:03 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 12:51:03 INFO - Using env: {'DISPLAY': ':0', 12:51:03 INFO - 'HOME': '/home/cltbld', 12:51:03 INFO - 'LANG': 'en_US.UTF-8', 12:51:03 INFO - 'LANGUAGE': 'en_US:en', 12:51:03 INFO - 'LOGNAME': 'cltbld', 12:51:03 INFO - 'MAIL': '/var/mail/cltbld', 12:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:03 INFO - 'MOZ_NO_REMOTE': '1', 12:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:03 INFO - 'NO_EM_RESTART': '1', 12:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:03 INFO - 'PWD': '/builds/slave/test', 12:51:03 INFO - 'SHELL': '/bin/bash', 12:51:03 INFO - 'SHLVL': '1', 12:51:03 INFO - 'TERM': 'linux', 12:51:03 INFO - 'TMOUT': '86400', 12:51:03 INFO - 'USER': 'cltbld', 12:51:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:03 INFO - '_': '/tools/buildbot/bin/python'} 12:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 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)) 12:51:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:51:05 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)) 12:51:05 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)) 12:51:05 INFO - Installing collected packages: simplejson 12:51:05 INFO - Running setup.py install for simplejson 12:51:05 INFO - building 'simplejson._speedups' extension 12:51:05 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 12:51:06 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 12:51:06 INFO - Successfully installed simplejson 12:51:06 INFO - Cleaning up... 12:51:06 INFO - Return code: 0 12:51:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:51:06 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')]} 12:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:06 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')]} 12:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:06 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 0xf6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1135a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12dcb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, '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': '4300f881736b422476174874000001bc-1504036214.23745-602349572', '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 12:51:06 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 12:51:06 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 12:51:06 INFO - Using env: {'DISPLAY': ':0', 12:51:06 INFO - 'HOME': '/home/cltbld', 12:51:06 INFO - 'LANG': 'en_US.UTF-8', 12:51:06 INFO - 'LANGUAGE': 'en_US:en', 12:51:06 INFO - 'LOGNAME': 'cltbld', 12:51:06 INFO - 'MAIL': '/var/mail/cltbld', 12:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:06 INFO - 'MOZ_NO_REMOTE': '1', 12:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:06 INFO - 'NO_EM_RESTART': '1', 12:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:06 INFO - 'PWD': '/builds/slave/test', 12:51:06 INFO - 'SHELL': '/bin/bash', 12:51:06 INFO - 'SHLVL': '1', 12:51:06 INFO - 'TERM': 'linux', 12:51:06 INFO - 'TMOUT': '86400', 12:51:06 INFO - 'USER': 'cltbld', 12:51:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:06 INFO - '_': '/tools/buildbot/bin/python'} 12:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:51:06 INFO - Cleaning up... 12:51:06 INFO - Return code: 0 12:51:06 INFO - Running post-action listener: _resource_record_post_action 12:51:06 INFO - Running post-action listener: _start_resource_monitoring 12:51:06 INFO - Starting resource monitoring. 12:51:06 INFO - [mozharness: 2017-08-29 19:51:06.444263Z] Finished create-virtualenv step (success) 12:51:06 INFO - [mozharness: 2017-08-29 19:51:06.444776Z] Running install step. 12:51:06 INFO - Running pre-action listener: _resource_record_pre_action 12:51:06 INFO - Running main action method: install 12:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:51:06 INFO - Reading from file tmpfile_stdout 12:51:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:51:06 INFO - Reading from file tmpfile_stdout 12:51:06 INFO - Output received: 12:51:06 INFO - Usage: mozinstall [options] installer 12:51:06 INFO - Options: 12:51:06 INFO - -h, --help show this help message and exit 12:51:06 INFO - -d DEST, --destination=DEST 12:51:06 INFO - Directory to install application into. [default: 12:51:06 INFO - "/builds/slave/test"] 12:51:06 INFO - --app=APP Application being installed. [default: firefox] 12:51:06 INFO - mkdir: /builds/slave/test/build/application 12:51:06 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'] 12:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:51:23 INFO - Reading from file tmpfile_stdout 12:51:23 INFO - Output received: 12:51:23 INFO - /builds/slave/test/build/application/firefox/firefox 12:51:23 INFO - Running post-action listener: _resource_record_post_action 12:51:23 INFO - [mozharness: 2017-08-29 19:51:23.079722Z] Finished install step (success) 12:51:23 INFO - [mozharness: 2017-08-29 19:51:23.080007Z] Running setup-mitmproxy step. 12:51:23 INFO - Running pre-action listener: _resource_record_pre_action 12:51:23 INFO - Running main action method: setup_mitmproxy 12:51:23 INFO - Skipping: mitmproxy is not required 12:51:23 INFO - Running post-action listener: _resource_record_post_action 12:51:23 INFO - [mozharness: 2017-08-29 19:51:23.081129Z] Finished setup-mitmproxy step (success) 12:51:23 INFO - [mozharness: 2017-08-29 19:51:23.081402Z] Running run-tests step. 12:51:23 INFO - Running pre-action listener: _resource_record_pre_action 12:51:23 INFO - Running pre-action listener: _set_gcov_prefix 12:51:23 INFO - Running main action method: run_tests 12:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:51:23 INFO - Python 2.7.3 12:51:23 INFO - Return code: 0 12:51:23 INFO - grabbing minidump binary from tooltool 12:51:23 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')]} 12:51:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x12d9580>, '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 0x12da480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12da910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:51:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 12:51:23 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:51:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 12:51:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:51:23 INFO - Return code: 0 12:51:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:51:23 INFO - ENV: RUST_BACKTRACE is now full 12:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:51:23 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/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 12:51:23 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/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 12:51:23 INFO - Using env: {'DISPLAY': ':0', 12:51:23 INFO - 'HOME': '/home/cltbld', 12:51:23 INFO - 'LANG': 'en_US.UTF-8', 12:51:23 INFO - 'LANGUAGE': 'en_US:en', 12:51:23 INFO - 'LOGNAME': 'cltbld', 12:51:23 INFO - 'MAIL': '/var/mail/cltbld', 12:51:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:23 INFO - 'MOZ_NO_REMOTE': '1', 12:51:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:23 INFO - 'NO_EM_RESTART': '1', 12:51:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:23 INFO - 'PWD': '/builds/slave/test', 12:51:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:23 INFO - 'RUST_BACKTRACE': 'full', 12:51:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:23 INFO - 'SHELL': '/bin/bash', 12:51:23 INFO - 'SHLVL': '1', 12:51:23 INFO - 'TERM': 'linux', 12:51:23 INFO - 'TMOUT': '86400', 12:51:23 INFO - 'USER': 'cltbld', 12:51:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:23 INFO - '_': '/tools/buildbot/bin/python'} 12:51:23 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/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 12:51:23 INFO - mozversion application_buildid: 20170829183112 12:51:23 INFO - mozversion application_changeset: 6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4 12:51:23 INFO - mozversion application_display_name: Nightly 12:51:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:51:23 INFO - mozversion application_name: Firefox 12:51:23 INFO - mozversion application_remotingname: firefox 12:51:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:51:23 INFO - mozversion application_vendor: Mozilla 12:51:23 INFO - mozversion application_version: 57.0a1 12:51:23 INFO - mozversion platform_buildid: 20170829183112 12:51:23 INFO - mozversion platform_changeset: 6c3510bac83299cbaffd2d5ecfa8ef114da6c0c4 12:51:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:51:23 INFO - mozversion platform_version: 57.0a1 12:51:23 INFO - using testdate: 1504036283 12:51:23 INFO - actual date: 1504036283 12:51:23 INFO - starting webserver on 'localhost:59647' 12:51:23 INFO - SUITE-START | Running 2 tests 12:51:23 INFO - TEST-START | dromaeo_css 12:51:23 INFO - Initialising browser for dromaeo_css test... 12:51:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59647/getInfo.html -profile /tmp/tmpOaM4vJ/profile 12:51:23 INFO - TEST-INFO | started process 4312 (/builds/slave/test/build/application/firefox/firefox http://localhost:59647/getInfo.html) 12:51:29 INFO - TEST-INFO | 4312: exit 0 12:51:29 INFO - Browser initialized. 12:51:29 INFO - Running cycle 1/1 for dromaeo_css test... 12:51:29 INFO - Using env: {'DISPLAY': ':0', 12:51:29 INFO - 'HOME': '/home/cltbld', 12:51:29 INFO - 'JSGC_DISABLE_POISONING': '1', 12:51:29 INFO - 'LANG': 'en_US.UTF-8', 12:51:29 INFO - 'LANGUAGE': 'en_US:en', 12:51:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:51:29 INFO - 'LOGNAME': 'cltbld', 12:51:29 INFO - 'MAIL': '/var/mail/cltbld', 12:51:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:29 INFO - 'MOZ_CRASHREPORTER': '1', 12:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:51:29 INFO - 'MOZ_NO_REMOTE': '1', 12:51:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:29 INFO - 'NO_EM_RESTART': '1', 12:51:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:29 INFO - 'PWD': '/builds/slave/test', 12:51:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:29 INFO - 'RUST_BACKTRACE': 'full', 12:51:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:29 INFO - 'SHELL': '/bin/bash', 12:51:29 INFO - 'SHLVL': '1', 12:51:29 INFO - 'TERM': 'linux', 12:51:29 INFO - 'TMOUT': '86400', 12:51:29 INFO - 'USER': 'cltbld', 12:51:29 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 12:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:29 INFO - '_': '/tools/buildbot/bin/python'} 12:51:29 INFO - TEST-INFO | started process 4502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOaM4vJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:30 INFO - PID 4502 | 12:51:30 INFO - PID 4502 | (/builds/slave/test/build/application/firefox/firefox:4553): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:51:30 INFO - PID 4502 | 12:51:40 INFO - PID 4502 | RSS: Main: 158126080 12:51:40 INFO - PID 4502 | 12:54:39 INFO - PID 4502 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59647/tests/dromaeo/cssquery-ext.html) 12:54:40 INFO - PID 4502 | RSS: Main: 164311040 12:54:40 INFO - PID 4502 | 12:57:41 INFO - PID 4502 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-ext.html (next: http://localhost:59647/tests/dromaeo/cssquery-jquery.html) 12:57:42 INFO - PID 4502 | RSS: Main: 160628736 12:57:42 INFO - PID 4502 | 13:00:44 INFO - PID 4502 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59647/tests/dromaeo/cssquery-mootools.html) 13:00:44 INFO - PID 4502 | RSS: Main: 163213312 13:00:44 INFO - PID 4502 | 13:03:46 INFO - PID 4502 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59647/tests/dromaeo/cssquery-prototype.html) 13:03:46 INFO - PID 4502 | RSS: Main: 161579008 13:03:46 INFO - PID 4502 | 13:06:50 INFO - PID 4502 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59647/tests/dromaeo/cssquery-yui.html) 13:06:50 INFO - PID 4502 | RSS: Main: 164917248 13:06:50 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | Cycle 1(1): loaded http://localhost:59647/tests/dromaeo/cssquery-yui.html (next: http://localhost:59647/tests/dromaeo/cssquery-dojo.html) 13:09:52 INFO - PID 4502 | RSS: Main: 164245504 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | __start_tp_report 13:09:52 INFO - PID 4502 | _x_x_mozilla_page_load 13:09:52 INFO - PID 4502 | _x_x_mozilla_page_load_details 13:09:52 INFO - PID 4502 | |i|pagename|runs| 13:09:52 INFO - PID 4502 | |0;dojo.html;3864.7874366909828;3897.9025524361878;3906.4335671327653;3934.980325098374;3938.0548668319593;6810.421114205298;6881.277465866087;6892.414144797692;6909;6920.169579650449;6752.831179220522;6823.965880170605;6833.794986150411;6836.863262734742;6893.724251029953;6091.9390806091815;6105.023196288595;6133.6626485543275;6136.202293701813;6153;6114.663693496856;6134.6012509186985;6142.631442113465;6200.720967556471;6215.036669316263;6176.382361763833;6226.190595222614;6231.40801623845;6231.5326350523665;6297.811065668037;6101.115338275969;6175.660338681393;6181.6600086995195;6192.81421557354;6235.750569977218;5975.820725378246;5980.282366116094;6005;6119.1739115219325;6212.192414986068;6750.662466876685;6821.795346139624;6866.141732283465;6928.1339832520935;6941.479389045791;7306.232845551193;7368.336849683555;7371.594562299071;7497.5126616770285;7509.549427034395;7465.29079737424;7466.290702383265;7536.284053014955;7591.81020474487;7597.088349398107;6948.826279342956;6978.337057979484;7028.086348774677;7037.296270372973;7046.964765176142;7666.923330766733;7671.424643151786;7684.6157692116285;7697.999260096263;7776.144624091346;7146.106736657918;7249.311315425026;7395.334419902235;7472.70109195637;7485.25147485258;7418.554886706815;7470.626468676544;7475.551466912003;7542.962285188539;7570.810729731801;7336.669849856769;7366.042414486083;7397.667104980289;7457.291557302047;7541.057367829021;7435.51669141504;7440.218777028443;7542.396608271325;7542.811429714301;7548.849023019508;6271.184745982993;6323.114763933053;6371.840703982438;6391.488680905516;6406.903896441557;5415.702136382458;5483.369412517532;5585.273914391184;5586.525145362609;5614.803481878196;6202.41077097675;6364.809055728336;6366.204224471941;6377.139086223393;6446.709898054505;7367.410607151415;7367.4842761007285;7377;7459.664315105833;7493.812654683567;6359.650219237894;6379.489640828722;6440.710168042449;6441.323661015525;6445.871082578322;6589.209294884645;6669.833254168588;6702.229243637044;6759.087523184406;6763.222229443677;7201.747938822116;7250.238724933912;7250.347468727839;7257.52826066304;7263.527870688388;7322.28543161019;7337.963310183629;7402;7432.145303290191;7437.219091995479;7220.566765994057;7247.782566523013;7254.782356529313;7265.12818461788;7285.963570182115;7319.5242309249725;7345.155307139534;7388.593627350548;7395.630218488946;7427.962860185665;7290.635468226461;7391.593462359622;7394.112706475257;7511.661975211238;7518;7163.212046674966;7185.820354491179;7188.137423509213;7193.100862392201;7193.388561972291;7165.713371465292;7167.820804479721;7175.748848790267;7201.279872012757;7231.602261875437;7180.31786980236;7180.533265337736;7189.137303523401;7228;7236.674349654173;7156.785296441115;7198.89201661965;7261.673224704795;7273.0908636420445;7329.377002954595;6941.34057264559;6985.1617805863625;7001.8249543759775;7030.9296907030275;7037.1555413350725 13:09:52 INFO - PID 4502 | |1;ext.html;953.5184731710485;968.4528241543527;993.821112199804;1021.7139201023716;1021.7649940513681;44653;45227.32159017617;45289.547104528945;45320.77339613305;45634.7718261409;42300.57699423005;42670.57329426705;42785.57214427862;42808.785956070176;42836.78581607095;7473.813154671149;7581.3555847753005;7584.544927304351;7598.924010759904;7602.6958921643345;7493.962530187341;7558.395328373745;7560.848783024337;7568.281013303755;7568.318851303382;7554.546727196358;7578.9389485472075;7587.696492140335;7591.316781489665;7594.468387212897;7551.433642476809;7573.7727868163765;7581.166071732133;7581.696732130708;7582.658780354842;6898.586084834876;6967;6968.756093536753;6974.755883544051;6976.058232138647;36551.4517282241;36764.63235367639;36792.08019799527;36793;36828.079298017496;3624.6194149614175;3640.2719456108885;3643.617420170897;3646.6717995380545;3646.9817650911577;29618;29796.70203297961;29859.850700746574;29886;29917.850410748026;4687.437507499122;4934.1611925972675;4938.678985865943;4980.203167493184;5015.3229314042865;213154.99999999846;215030;215172;215553;215978.99999999843;24988.500229995298;25017.4996500069;25022.249332520052;25094.749052509607;25124;60521.39478605158;60704;60881.69559152176;60886;61257.69371153205;16724.74912876308;16992.660146796996;17016.404425845038;17028.744568831476;17043;13496.865031349756;13660.11209271414;13694.657633559042;13746.175229486264;13783.793243101361;16107.275172617261;16155.353785848669;16208.51374458768;16212.75680864788;16227;6119.816405507842;6139.754409823647;6187.288461826947;6259.7496100156395;6304.338044505353;1101.6199411203122;1108.7394462301352;1113.1095123900848;1113.9554417823197;1129.6102844518628;25423;25461.3634659135;25577.488450230892;25656.102036428634;25667.358316041875;1211.4972286501004;1227.4353797253364;1234.1237721218035;1242.465739731924;1249.2941488059398;13759.17444953306;13767;13779.379927903268;18088.63822723538;18159.27362905469;288139;288765;289020;289884;290232;59882.70058649766;62326.68836655788;62779.37220627735;64773;64958.35041649523;1521.117751704009;1552.154076028567;1557.1746974103744;1561.11796834788;1563.5231254467496;29638.70361296446;29729.85135074311;30147;30610;31179;42783.14433711371;42926.570734292254;42948.35577466278;42983.355249670654;43081.353779692705;250228;250280;250394;251511;251547;37894.431583525715;37988.20117988179;38006.619933800306;38052.23895522129;38261.61738382692;46565.76717116393;47273;47619.76190119166;47775.76112119417;48107;34273.31453370869;34424.82787586046;36642.45036324404;37532.81233593924;38135;36594.634053660186;36605;36717.816410917774;36977.260454790216;37147.62852371442;42862.57137428711;42928;43167.35248971205;43802.78098609487;43861;35140.29719405649;35156.47265290972;35178.120546985505;35281.82359088188;35310.47034294436;25662.230133096036;25833.483330333664;26276.474470510864;26445.206643800717;26746.59880101761 13:09:52 INFO - PID 4502 | |2;jquery.html;595.4730063893455;600.147790138004;604.5405491826216;604.8356912942585;619.4734475695658;23251.534969300646;23579.882100589493;24334.269971900827;24340.634890476656;24342.513149736995;26871.193864184104;27128.728712712866;27255;27343.726562734366;27356.31609209766;6781.932180678179;6920.031195632616;6920.5847649141215;6946.097007389032;6949.791506254795;6515.41361277485;6757.358050985148;6781.932180678204;6787.592744435325;6787.898181527281;6741.696623651947;6744.359285867835;6745.696443660047;6750.054992301082;6751.459883209356;6720.630365329905;6729.6971636276485;6731.730730770788;6736.932630673679;6741.59550426976;6270.216222972129;6276.717547710364;6282.780102696383;6286.811395658137;6293.056041593752;30003.249918751986;30600.8469957651;31504.684953150634;31652.683473165205;31662.525062124085;2184.6067707812585;2202.4714068623416;2208.5251670890834;2210.812080973119;2212.5021870079263;20279.5944081119;20793.792062079337;20793.792062079337;20817.58364832695;20941;2492.626106084084;2535.366158460385;2578.406966397739;2580.4452042810885;2589.961150582743;159413.20293398574;162523;162693;162763;162890;15704.842951570567;16157.353705851869;16169;16599.83400166007;16847;25587.87206063995;25617.743822561908;25644.974201032124;25651.871740641178;25712;10618.1505479563;10918.344899306067;10936.835947460795;10943.23397362193;10958.506867190996;8780.341474389446;9129.360944733939;9699.224062075016;9966.20270378368;10093.192544596415;9872;10213;10245.385276883411;10252.743681408025;10265.486725663686;2938.3241854373614;2946.130891387046;2948.498755211619;2948.9852550737537;3009.6990300970165;1037.5434808684154;1071.6195750508457;1075.2795228944938;1086.5708045322053;1087.0705546757408;21634;21869.343919682437;22209.44476388071;22448;22634.547309054054;1078.6224821312478;1130.6381957773433;1146.4325159046325;1149.7183190118308;1151.6890439581434;11743.88256117428;11959.581414650445;12029.759404811855;12066.758664826655;12286.938565307117;638468;650617;654517;672207;673696;133776;139623;139851;142403;143210;1291.12203701482;1293.7089154940252;1322.9007824413206;1323.6227675112548;1325.1254172246272;19471.318503852297;19727.605447890674;19769.70345444848;19885.801141988395;19914.50213744668;61943.070853936326;63658.68170659117;64213.67893160504;65538;66682;79604.60197698974;80532.59733701294;80700;81429;81567;15448.613784655474;15967.121808300655;15970.68058638844;15984.760228596813;16015.839841601435;24707.505849883262;25084.874575627004;25090.62364064577;25140.74859251384;26044;20941.89529052345;21059;21082.78917210808;21150.048247828578;21163.68254476215;17843.464696059138;18951.0524473773;19054.42836714901;19159;19231.615367692848;21508.569828603653;21800.236991705213;21961.121555137615;22078.22726204575;22120.115195392005;15744.685106298039;15898.68202635964;15939.8406015943;15980.28088736033;16127.758083628989;20540.897295513427;20611.38165855027;20652.79347206509;20676.379708608765;20878.895605521877 13:09:52 INFO - PID 4502 | |3;mootools.html;1465.120927443534;1528.892977491576;1534.5473085439792;1537.423466200175;1544.1815837606073;15955;16605.33578656854;16642.167891605433;16647.66704665909;17180.22688978996;17448.389306374247;17696.911515442436;17703;17725.468235952943;17738.29046838125;2866.527023041201;2899.1592438192897;2918.3141961639;2919.343147791751;2922.3862988772385;2810.1148138336357;2901.05715642416;2902.62265905432;2903.3467469819334;2905.8837646494117;2786.4984302825483;2790.8185967912123;2796.7622752065995;2796.9021084262054;2800.313923088846;2806.564982427727;2809.8314101153996;2819.6334476518127;2819.8590070496393;2823.5623478360785;2698.9595156072673;2702.486527559757;2719.809613327068;2722.6460560127257;2723.836569805818;16246.75629865553;16576.66846663072;16593.83406165947;16612;16620.750688739678;8357.582120893992;8608.225259726592;8617.095205003447;8618.525981071038;8646.092160323138;5396.460353964611;5520.1443776214755;5612.579056570774;5620.606557540974;5622.718864056781;2058.423641380416;2088.1334246287774;2096.643570593003;2132;2142.046789178816;29493.557596636067;29725.851370743007;29727.25681857949;29776.553351699742;29790;7190.496665233383;7258.854822903512;7297.489175757646;7364.189939106694;7426.777196684108;18992.145353459127;18994.905025474785;18999.335023274118;19026.904865475582;19131.33040343581;7533.698652053857;8064.830599563148;8073.83852322962;8363.121872203332;8538.573071346407;6651;6846.657667116724;7331.266873312626;7792.532448053135;7949.880751788728;5453.481919217668;5636.897509138433;5675.574331925122;5727.599068065196;5896.587238893322;1621.4892308922651;1634.942777002823;1638.1399765123167;1651.900885946847;1653.1649868645793;993.4089216915924;1004.5228516454625;1015.167562598662;1019.7960407918446;1033.2302434686208;8652.307815374756;8729.170728780755;8825.735227943173;8897.332700047393;8907.421017633833;744.8994385757961;761.6268028665913;772.2239149654673;784.7253461288503;792.7066985215507;5023.723695196799;5126.077306084866;5619.719014049281;5782.421757824184;5859.326177489558;24392.390190245387;25115.246542603752;25116.748832511443;25137.62293565598;25249;23901.282961511184;25285.367865803135;25311.746882531308;25350.492990140094;25400.618990714785;11554.133439992034;12047;12090.455929483194;12096.81854772179;12134.211276267015;9507.619695212114;9538.95230523843;9801.950990245003;9854.408735475894;9934.403935763878;20438.386848394573;20487.999999999403;20665.586688266452;20751.584968300853;21101.57796844085;21810.781892180876;21878.343649690534;21990;22112.44718882041;22929.197478088186;11200.887991120311;11540.422978851191;11599.478023489131;12164.513419463123;12428.067894907737;14725.705485890436;14779.334929927963;14792.778108328168;14798.6300342488;14823.629409264855;11532.94233528827;11638;11731.88268117308;11758.823617645914;12283.754324913272;11792.823107653563;11938.76122477563;12069.818952715892;12098.455569499569;12129.514819407124;10569.788604228026;10624.096951759188;10624.415657138932;10671.816444357788;10679.359238445719;8052.718154864551;8294.751157465285;8314.916850831414;8344.749657510285;8429.452085614415;8284.378671599534;8433.283170930294;8464.66141354339;8590;8661.740147795575 13:09:52 INFO - PID 4502 | |4;prototype.html;551.7461967494952;562.77207730869;576.250873863977;576.971151442428;580.817042631571;6832.624205668686;6855.828604284895;6858.7942361729165;6891.4831387646;6922.584644921296;6721.630310332942;6753.223379311381;6777.2545020047755;6779.932200677992;6806.319368063191;5447.428020057896;5472.20653005314;5493.450654934514;5517.586181036419;5524.723763811813;5158.406783219922;5446.576273558268;5502.257195278627;5511.173324001412;5540;5240.764165612557;5261.816091379447;5274.709890955995;5277;5320.095583750753;5256.237845512379;5277.419483856773;5278.973605131988;5312.096943519611;5319.308489896327;4769.928451073237;4778.757523043999;4792.113459010059;4794.760261986921;4796.736179510125;6616.503762217805;6660.601273732522;6666.799996000079;6671.799846004627;6672.899906501407;6290.937090629081;6292.150559674431;6307.716152773136;6313.210848643919;6333.96833015832;6986.755463558751;7051.519180972002;7056.894146587805;7174.197675232135;7198.676059577331;5257.815976440845;5278.577713782888;5334.626576139672;5347.732613369316;5359.276497672803;7118.501704880712;7268.309510596485;7350.301721336465;7503.174650788409;7545.924540754632;5361.249425080492;5372.952274306473;5377.193420986883;5426.131818908955;5453.15476101205;5506.394296627368;5515.531179849758;5521.116621340566;5565.3304008797195;5569.888602227933;6196.349383314777;6229.4393504583895;6248.4064013918605;6266.749330026748;6277.905831412532;7117.932310153415;7150.284971502912;7207;7211.639418029077;7220.74727384539;1894.2612381171355;1902.4482899959135;1914.9712754308696;1917.8465722742146;1926.5280006398523;1294.3851670456645;1316.9341532923315;1328.2296268164635;1334.8998825088158;1344.253939063829;6101.96949015261;6213.285472170668;6235.971064774352;6237;6243.313235544087;7056.788296351117;7077.92922070783;7136.928630713626;7137.678804453812;7209.459290553124;6169.81490555284;6212.627242365382;6235.127082208494;6255.6872156392;6264.123022776815;3815.3704638734853;3819.3316169670197;3833.290841194388;3882.6893848492055;3886.9222615548097;7016.929830701628;7027.43780497559;7078.823029424306;7138.9286107139305;7165.247648996885;7508;7526.725874244721;7533.962330188314;7558.9244107558225;7574.204708505527;6929;7067.89398159028;7084.893726594105;7100.502964792415;7152.606606636685;7216.458765592497;7278.235785242473;7295.489315748059;7325.4872158948365;7354.338109570164;7155.141383034069;7278.617062758059;7361.521501102411;7363.484556081023;7368;6946.479014074066;6950.374466298057;7045.753398631228;7067;7071.398931090915;5365;5366.382865970463;5383.165609330404;5398.892022159614;5408.972955135199;7175;7306.926930730625;7307.159676637255;7344.265573442826;7360.263973602597;6706.631135287606;6957.721691132298;6976.267491913276;7024.4029257513685;7047.6123813188715;6906;6925.342092501204;6928.549644273106;6962.189830643968;7074.858502829811;6777.356151165632;6836.316368363124;6988.126484189476;7029.789106326818;7048.365647091787;7031.753888613874;7052.18899826506;7085.681144348414;7090.4327653788605;7123.893141602984;6810.897836532555;6821.93178068213;6897.965510172417;6916.446684265146;6992.300769922967 13:09:52 INFO - PID 4502 | |5;yui.html;959.7024922274096;998.1116806042621;1003.2375394700031;1007.7883644434669;1017.872765904262;16593.585160370996;17068.573285667866;17116.828831711693;17145.91427042866;18667.533311667215;18296.908515457406;18298.542536436595;18421.723674144898;18469.81530184701;18515.537111572183;1076.8707755069402;1105.9659218630607;1106.435717783932;1106.955721771128;1107.7618312062905;1045.6131231444376;1078.9244752867303;1088.9455527223647;1089.3463921646987;1090.2640717515685;1153.948072336747;1154.0133186125868;1154.0709728668419;1154.3477934966759;1154.4227886056972;1147.1625713229348;1147.8852114788538;1151.4645689754263;1152.038048229725;1152.130141742987;847.9703210387669;848.1645579104577;849.7365816596874;851.880736696863;852.075498084579;17289.394871179575;17509.387171449067;17509.737353939574;17584.384546540936;18019.72970405445;19281.132349044186;19353.80646193548;19625.9018704907;19983.700244496344;19995.400137995883;15447.30487128082;15475.613109672237;15612.219389030502;15618;15628.687426251525;3800.1069748609057;3891.1633998690136;3891.9221615567812;3893.2602805467154;3894.1432884765304;147588.99999999892;148593;149199;149431.2528437351;154121;13778.793318100237;14109.223992680501;14150.433982640785;14253.714925701428;14266.714665706835;28130.71869281281;29659.55510667342;29751.553726694117;29986;30002;8528.488290702579;8821;9256.444613323221;9449.952750236205;9462.195713364303;3939.1924655445564;4068.2880495913096;4151.522574903925;4281.443412356373;4479.126570318756;4894.657373983858;5025.7989680412375;5039.4708555601865;5043.36957880265;5045.596352291808;1111.8332250162541;1132.9660110196708;1142.9142814288962;1147.3058799426394;1147.4434899073942;735.1472292141198;760.6501009535565;761.3680645064583;780.574586850168;786.6066966516742;11852.762944741056;12553.811692824615;12562.309073001074;13291.933540332237;13314.134581252187;752.1012390193666;755.6675062972274;758.9051368578928;760.6462994707488;769.7498313048281;5741.827745167651;5798.057321021662;5809.535237181015;6042.728077236535;6061.030235162441;135900;135920;136001;140218;142171;122355.38822305831;122359;122829;123468;128927.35536322258;97804.51097744466;100722.49638751759;102241;105621;106248;13264;13611.047226694433;13785.724285514032;13789.586312410644;14016.579502614937;47784.761076195784;48199;49256.50743492663;49811.75094124506;51142.74428627833;78614.606926965;80623.59688201756;81353;83001;85787.57106214679;18205.908970455064;18215.635687286445;18418.447446576625;18544.350947716764;18587.90706046461;18788.624227515098;19521.511962201057;20110.39668809938;20399.388018359474;21838.344849654535;20013.39959801208;20517.692234616195;20870.582588347843;20961.475963100434;21132.894335528224;20823.271185508434;20831.8958405207;20980;21035.8948205258;21475.355739327846;20356.389308320773;20536.178552857717;20655.981848803618;20669.483262918548;21006.579868402852;13656;14232.501862434765;14408;14812.851871481147;14910.630995554917;14482.565523034325;14613.050151740103;14628.707425851637;14721.411143554138;14765.114093154445 13:09:52 INFO - PID 4502 | __end_tp_report 13:09:52 INFO - PID 4502 | __start_cc_report 13:09:52 INFO - PID 4502 | _x_x_mozilla_cycle_collect,344 13:09:52 INFO - PID 4502 | __end_cc_report 13:09:52 INFO - PID 4502 | __startTimestamp1504037392689__endTimestamp 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | ------- Summary: start ------- 13:09:52 INFO - PID 4502 | Number of tests: 6 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | [#0] dojo.html Cycles:165 Average:6846.00 Median:7163.21 stddev:754.06 (10.5%) stddev-sans-first:719.19 13:09:52 INFO - PID 4502 | Values: 3864.8 3897.9 3906.4 3935.0 3938.1 6810.4 6881.3 6892.4 6909.0 6920.2 6752.8 6824.0 6833.8 6836.9 6893.7 6091.9 6105.0 6133.7 6136.2 6153.0 6114.7 6134.6 6142.6 6200.7 6215.0 6176.4 6226.2 6231.4 6231.5 6297.8 6101.1 6175.7 6181.7 6192.8 6235.8 5975.8 5980.3 6005.0 6119.2 6212.2 6750.7 6821.8 6866.1 6928.1 6941.5 7306.2 7368.3 7371.6 7497.5 7509.5 7465.3 7466.3 7536.3 7591.8 7597.1 6948.8 6978.3 7028.1 7037.3 7047.0 7666.9 7671.4 7684.6 7698.0 7776.1 7146.1 7249.3 7395.3 7472.7 7485.3 7418.6 7470.6 7475.6 7543.0 7570.8 7336.7 7366.0 7397.7 7457.3 7541.1 7435.5 7440.2 7542.4 7542.8 7548.8 6271.2 6323.1 6371.8 6391.5 6406.9 5415.7 5483.4 5585.3 5586.5 5614.8 6202.4 6364.8 6366.2 6377.1 6446.7 7367.4 7367.5 7377.0 7459.7 7493.8 6359.7 6379.5 6440.7 6441.3 6445.9 6589.2 6669.8 6702.2 6759.1 6763.2 7201.7 7250.2 7250.3 7257.5 7263.5 7322.3 7338.0 7402.0 7432.1 7437.2 7220.6 7247.8 7254.8 7265.1 7286.0 7319.5 7345.2 7388.6 7395.6 7428.0 7290.6 7391.6 7394.1 7511.7 7518.0 7163.2 7185.8 7188.1 7193.1 7193.4 7165.7 7167.8 7175.7 7201.3 7231.6 7180.3 7180.5 7189.1 7228.0 7236.7 7156.8 7198.9 7261.7 7273.1 7329.4 6941.3 6985.2 7001.8 7030.9 7037.2 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | [#1] ext.html Cycles:180 Average:42764.02 Median:36599.82 stddev:66064.25 (180.5%) stddev-sans-first:66174.98 13:09:52 INFO - PID 4502 | Values: 953.5 968.5 993.8 1021.7 1021.8 44653.0 45227.3 45289.5 45320.8 45634.8 42300.6 42670.6 42785.6 42808.8 42836.8 7473.8 7581.4 7584.5 7598.9 7602.7 7494.0 7558.4 7560.8 7568.3 7568.3 7554.5 7578.9 7587.7 7591.3 7594.5 7551.4 7573.8 7581.2 7581.7 7582.7 6898.6 6967.0 6968.8 6974.8 6976.1 36551.5 36764.6 36792.1 36793.0 36828.1 3624.6 3640.3 3643.6 3646.7 3647.0 29618.0 29796.7 29859.9 29886.0 29917.9 4687.4 4934.2 4938.7 4980.2 5015.3 213155.0 215030.0 215172.0 215553.0 215979.0 24988.5 25017.5 25022.2 25094.7 25124.0 60521.4 60704.0 60881.7 60886.0 61257.7 16724.7 16992.7 17016.4 17028.7 17043.0 13496.9 13660.1 13694.7 13746.2 13783.8 16107.3 16155.4 16208.5 16212.8 16227.0 6119.8 6139.8 6187.3 6259.7 6304.3 1101.6 1108.7 1113.1 1114.0 1129.6 25423.0 25461.4 25577.5 25656.1 25667.4 1211.5 1227.4 1234.1 1242.5 1249.3 13759.2 13767.0 13779.4 18088.6 18159.3 288139.0 288765.0 289020.0 289884.0 290232.0 59882.7 62326.7 62779.4 64773.0 64958.4 1521.1 1552.2 1557.2 1561.1 1563.5 29638.7 29729.9 30147.0 30610.0 31179.0 42783.1 42926.6 42948.4 42983.4 43081.4 250228.0 250280.0 250394.0 251511.0 251547.0 37894.4 37988.2 38006.6 38052.2 38261.6 46565.8 47273.0 47619.8 47775.8 48107.0 34273.3 34424.8 36642.5 37532.8 38135.0 36594.6 36605.0 36717.8 36977.3 37147.6 42862.6 42928.0 43167.4 43802.8 43861.0 35140.3 35156.5 35178.1 35281.8 35310.5 25662.2 25833.5 26276.5 26445.2 26746.6 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | [#2] jquery.html Cycles:180 Average:42196.42 Median:12166.31 stddev:110036.64 (904.4%) stddev-sans-first:110300.99 13:09:52 INFO - PID 4502 | Values: 595.5 600.1 604.5 604.8 619.5 23251.5 23579.9 24334.3 24340.6 24342.5 26871.2 27128.7 27255.0 27343.7 27356.3 6781.9 6920.0 6920.6 6946.1 6949.8 6515.4 6757.4 6781.9 6787.6 6787.9 6741.7 6744.4 6745.7 6750.1 6751.5 6720.6 6729.7 6731.7 6736.9 6741.6 6270.2 6276.7 6282.8 6286.8 6293.1 30003.2 30600.8 31504.7 31652.7 31662.5 2184.6 2202.5 2208.5 2210.8 2212.5 20279.6 20793.8 20793.8 20817.6 20941.0 2492.6 2535.4 2578.4 2580.4 2590.0 159413.2 162523.0 162693.0 162763.0 162890.0 15704.8 16157.4 16169.0 16599.8 16847.0 25587.9 25617.7 25645.0 25651.9 25712.0 10618.2 10918.3 10936.8 10943.2 10958.5 8780.3 9129.4 9699.2 9966.2 10093.2 9872.0 10213.0 10245.4 10252.7 10265.5 2938.3 2946.1 2948.5 2949.0 3009.7 1037.5 1071.6 1075.3 1086.6 1087.1 21634.0 21869.3 22209.4 22448.0 22634.5 1078.6 1130.6 1146.4 1149.7 1151.7 11743.9 11959.6 12029.8 12066.8 12286.9 638468.0 650617.0 654517.0 672207.0 673696.0 133776.0 139623.0 139851.0 142403.0 143210.0 1291.1 1293.7 1322.9 1323.6 1325.1 19471.3 19727.6 19769.7 19885.8 19914.5 61943.1 63658.7 64213.7 65538.0 66682.0 79604.6 80532.6 80700.0 81429.0 81567.0 15448.6 15967.1 15970.7 15984.8 16015.8 24707.5 25084.9 25090.6 25140.7 26044.0 20941.9 21059.0 21082.8 21150.0 21163.7 17843.5 18951.1 19054.4 19159.0 19231.6 21508.6 21800.2 21961.1 22078.2 22120.1 15744.7 15898.7 15939.8 15980.3 16127.8 20540.9 20611.4 20652.8 20676.4 20878.9 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | [#3] mootools.html Cycles:180 Average:10274.66 Median:2711.15 stddev:7618.75 (281.0%) stddev-sans-first:7611.37 13:09:52 INFO - PID 4502 | Values: 1465.1 1528.9 1534.5 1537.4 1544.2 15955.0 16605.3 16642.2 16647.7 17180.2 17448.4 17696.9 17703.0 17725.5 17738.3 2866.5 2899.2 2918.3 2919.3 2922.4 2810.1 2901.1 2902.6 2903.3 2905.9 2786.5 2790.8 2796.8 2796.9 2800.3 2806.6 2809.8 2819.6 2819.9 2823.6 2699.0 2702.5 2719.8 2722.6 2723.8 16246.8 16576.7 16593.8 16612.0 16620.8 8357.6 8608.2 8617.1 8618.5 8646.1 5396.5 5520.1 5612.6 5620.6 5622.7 2058.4 2088.1 2096.6 2132.0 2142.0 29493.6 29725.9 29727.3 29776.6 29790.0 7190.5 7258.9 7297.5 7364.2 7426.8 18992.1 18994.9 18999.3 19026.9 19131.3 7533.7 8064.8 8073.8 8363.1 8538.6 6651.0 6846.7 7331.3 7792.5 7949.9 5453.5 5636.9 5675.6 5727.6 5896.6 1621.5 1634.9 1638.1 1651.9 1653.2 993.4 1004.5 1015.2 1019.8 1033.2 8652.3 8729.2 8825.7 8897.3 8907.4 744.9 761.6 772.2 784.7 792.7 5023.7 5126.1 5619.7 5782.4 5859.3 24392.4 25115.2 25116.7 25137.6 25249.0 23901.3 25285.4 25311.7 25350.5 25400.6 11554.1 12047.0 12090.5 12096.8 12134.2 9507.6 9539.0 9802.0 9854.4 9934.4 20438.4 20488.0 20665.6 20751.6 21101.6 21810.8 21878.3 21990.0 22112.4 22929.2 11200.9 11540.4 11599.5 12164.5 12428.1 14725.7 14779.3 14792.8 14798.6 14823.6 11532.9 11638.0 11731.9 11758.8 12283.8 11792.8 11938.8 12069.8 12098.5 12129.5 10569.8 10624.1 10624.4 10671.8 10679.4 8052.7 8294.8 8314.9 8344.7 8429.5 8284.4 8433.3 8464.7 8590.0 8661.7 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | [#4] prototype.html Cycles:180 Average:5972.43 Median:6714.13 stddev:1675.24 (25.0%) stddev-sans-first:1629.78 13:09:52 INFO - PID 4502 | Values: 551.7 562.8 576.3 577.0 580.8 6832.6 6855.8 6858.8 6891.5 6922.6 6721.6 6753.2 6777.3 6779.9 6806.3 5447.4 5472.2 5493.5 5517.6 5524.7 5158.4 5446.6 5502.3 5511.2 5540.0 5240.8 5261.8 5274.7 5277.0 5320.1 5256.2 5277.4 5279.0 5312.1 5319.3 4769.9 4778.8 4792.1 4794.8 4796.7 6616.5 6660.6 6666.8 6671.8 6672.9 6290.9 6292.2 6307.7 6313.2 6334.0 6986.8 7051.5 7056.9 7174.2 7198.7 5257.8 5278.6 5334.6 5347.7 5359.3 7118.5 7268.3 7350.3 7503.2 7545.9 5361.2 5373.0 5377.2 5426.1 5453.2 5506.4 5515.5 5521.1 5565.3 5569.9 6196.3 6229.4 6248.4 6266.7 6277.9 7117.9 7150.3 7207.0 7211.6 7220.7 1894.3 1902.4 1915.0 1917.8 1926.5 1294.4 1316.9 1328.2 1334.9 1344.3 6102.0 6213.3 6236.0 6237.0 6243.3 7056.8 7077.9 7136.9 7137.7 7209.5 6169.8 6212.6 6235.1 6255.7 6264.1 3815.4 3819.3 3833.3 3882.7 3886.9 7016.9 7027.4 7078.8 7138.9 7165.2 7508.0 7526.7 7534.0 7558.9 7574.2 6929.0 7067.9 7084.9 7100.5 7152.6 7216.5 7278.2 7295.5 7325.5 7354.3 7155.1 7278.6 7361.5 7363.5 7368.0 6946.5 6950.4 7045.8 7067.0 7071.4 5365.0 5366.4 5383.2 5398.9 5409.0 7175.0 7306.9 7307.2 7344.3 7360.3 6706.6 6957.7 6976.3 7024.4 7047.6 6906.0 6925.3 6928.5 6962.2 7074.9 6777.4 6836.3 6988.1 7029.8 7048.4 7031.8 7052.2 7085.7 7090.4 7123.9 6810.9 6821.9 6898.0 6916.4 6992.3 13:09:52 INFO - PID 4502 | 13:09:52 INFO - PID 4502 | [#5] yui.html Cycles:180 Average:26971.95 Median:18420.09 stddev:39548.86 (214.7%) stddev-sans-first:39611.57 13:09:52 INFO - PID 4502 | Values: 959.7 998.1 1003.2 1007.8 1017.9 16593.6 17068.6 17116.8 17145.9 18667.5 18296.9 18298.5 18421.7 18469.8 18515.5 1076.9 1106.0 1106.4 1107.0 1107.8 1045.6 1078.9 1088.9 1089.3 1090.3 1153.9 1154.0 1154.1 1154.3 1154.4 1147.2 1147.9 1151.5 1152.0 1152.1 848.0 848.2 849.7 851.9 852.1 17289.4 17509.4 17509.7 17584.4 18019.7 19281.1 19353.8 19625.9 19983.7 19995.4 15447.3 15475.6 15612.2 15618.0 15628.7 3800.1 3891.2 3891.9 3893.3 3894.1 147589.0 148593.0 149199.0 149431.3 154121.0 13778.8 14109.2 14150.4 14253.7 14266.7 28130.7 29659.6 29751.6 29986.0 30002.0 8528.5 8821.0 9256.4 9450.0 9462.2 3939.2 4068.3 4151.5 4281.4 4479.1 4894.7 5025.8 5039.5 5043.4 5045.6 1111.8 1133.0 1142.9 1147.3 1147.4 735.1 760.7 761.4 780.6 786.6 11852.8 12553.8 12562.3 13291.9 13314.1 752.1 755.7 758.9 760.6 769.7 5741.8 5798.1 5809.5 6042.7 6061.0 135900.0 135920.0 136001.0 140218.0 142171.0 122355.4 122359.0 122829.0 123468.0 128927.4 97804.5 100722.5 102241.0 105621.0 106248.0 13264.0 13611.0 13785.7 13789.6 14016.6 47784.8 48199.0 49256.5 49811.8 51142.7 78614.6 80623.6 81353.0 83001.0 85787.6 18205.9 18215.6 18418.4 18544.4 18587.9 18788.6 19521.5 20110.4 20399.4 21838.3 20013.4 20517.7 20870.6 20961.5 21132.9 20823.3 20831.9 20980.0 21035.9 21475.4 20356.4 20536.2 20656.0 20669.5 21006.6 13656.0 14232.5 14408.0 14812.9 14910.6 14482.6 14613.1 14628.7 14721.4 14765.1 13:09:52 INFO - PID 4502 | -------- Summary: end -------- 13:09:52 INFO - PID 4502 | 13:09:53 INFO - TEST-INFO | 4502: exit 0 13:09:53 INFO - TEST-OK | dromaeo_css | took 1109977ms 13:09:53 INFO - TEST-START | kraken 13:09:53 INFO - Initialising browser for kraken test... 13:09:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59647/getInfo.html -profile /tmp/tmpflsl6l/profile 13:09:53 INFO - TEST-INFO | started process 4880 (/builds/slave/test/build/application/firefox/firefox http://localhost:59647/getInfo.html) 13:09:59 INFO - TEST-INFO | 4880: exit 0 13:09:59 INFO - Browser initialized. 13:09:59 INFO - Running cycle 1/1 for kraken test... 13:09:59 INFO - Using env: {'DISPLAY': ':0', 13:09:59 INFO - 'HOME': '/home/cltbld', 13:09:59 INFO - 'JSGC_DISABLE_POISONING': '1', 13:09:59 INFO - 'LANG': 'en_US.UTF-8', 13:09:59 INFO - 'LANGUAGE': 'en_US:en', 13:09:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 13:09:59 INFO - 'LOGNAME': 'cltbld', 13:09:59 INFO - 'MAIL': '/var/mail/cltbld', 13:09:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:59 INFO - 'MOZ_CRASHREPORTER': '1', 13:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 13:09:59 INFO - 'MOZ_NO_REMOTE': '1', 13:09:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:59 INFO - 'NO_EM_RESTART': '1', 13:09:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:59 INFO - 'PWD': '/builds/slave/test', 13:09:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:59 INFO - 'RUST_BACKTRACE': 'full', 13:09:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:09:59 INFO - 'SHELL': '/bin/bash', 13:09:59 INFO - 'SHLVL': '1', 13:09:59 INFO - 'TERM': 'linux', 13:09:59 INFO - 'TMOUT': '86400', 13:09:59 INFO - 'USER': 'cltbld', 13:09:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1504036214.23745-602349572', 13:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:59 INFO - '_': '/tools/buildbot/bin/python'} 13:09:59 INFO - TEST-INFO | started process 5067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpflsl6l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:00 INFO - PID 5067 | 13:10:00 INFO - PID 5067 | (/builds/slave/test/build/application/firefox/firefox:5118): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:10:00 INFO - PID 5067 | 13:10:10 INFO - PID 5067 | RSS: Main: 161882112 13:10:10 INFO - PID 5067 | 13:10:12 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-beat-detection) 13:10:13 INFO - PID 5067 | RSS: Main: 166649856 13:10:13 INFO - PID 5067 | 13:10:16 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-dft) 13:10:17 INFO - PID 5067 | RSS: Main: 171081728 13:10:17 INFO - PID 5067 | 13:10:19 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-fft) 13:10:20 INFO - PID 5067 | RSS: Main: 164143104 13:10:20 INFO - PID 5067 | 13:10:22 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59647/tests/kraken/driver.html?testName=audio-oscillator) 13:10:23 INFO - PID 5067 | RSS: Main: 164839424 13:10:23 INFO - PID 5067 | 13:10:25 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59647/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:10:25 INFO - PID 5067 | RSS: Main: 164659200 13:10:25 INFO - PID 5067 | 13:10:28 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59647/tests/kraken/driver.html?testName=imaging-darkroom) 13:10:29 INFO - PID 5067 | RSS: Main: 165093376 13:10:29 INFO - PID 5067 | 13:10:33 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59647/tests/kraken/driver.html?testName=imaging-desaturate) 13:10:33 INFO - PID 5067 | RSS: Main: 166690816 13:10:33 INFO - PID 5067 | 13:10:36 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59647/tests/kraken/driver.html?testName=json-parse-financial) 13:10:37 INFO - PID 5067 | RSS: Main: 166752256 13:10:37 INFO - PID 5067 | 13:10:38 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59647/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:10:39 INFO - PID 5067 | RSS: Main: 166539264 13:10:39 INFO - PID 5067 | 13:10:40 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:10:41 INFO - PID 5067 | RSS: Main: 167051264 13:10:41 INFO - PID 5067 | 13:10:43 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:10:44 INFO - PID 5067 | RSS: Main: 163700736 13:10:44 INFO - PID 5067 | 13:10:46 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:10:47 INFO - PID 5067 | RSS: Main: 163258368 13:10:47 INFO - PID 5067 | 13:10:50 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:10:50 INFO - PID 5067 | RSS: Main: 164085760 13:10:50 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | Cycle 1(1): loaded http://localhost:59647/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59647/tests/kraken/driver.html?testName=ai-astar) 13:10:52 INFO - PID 5067 | RSS: Main: 165605376 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | __start_tp_report 13:10:52 INFO - PID 5067 | _x_x_mozilla_page_load 13:10:52 INFO - PID 5067 | _x_x_mozilla_page_load_details 13:10:52 INFO - PID 5067 | |i|pagename|runs| 13:10:52 INFO - PID 5067 | |0;ai-astar;96;105;99;106;106;106;108;96;104;108 13:10:52 INFO - PID 5067 | |1;audio-beat-detection;146;112;145;176;114;140;141;118;167;115 13:10:52 INFO - PID 5067 | |2;audio-dft;162;163;163;161;161;163;162;161;170;167 13:10:52 INFO - PID 5067 | |3;audio-fft;72;73;73;101;76;73;80;88;95;74 13:10:52 INFO - PID 5067 | |4;audio-oscillator;78;78;126;78;77;77;126;78;78;126 13:10:52 INFO - PID 5067 | |5;imaging-gaussian-blur;115;114;114;114;115;114;114;115;115;113 13:10:52 INFO - PID 5067 | |6;imaging-darkroom;150;150;160;149;156;150;148;152;151;149 13:10:52 INFO - PID 5067 | |7;imaging-desaturate;93;94;94;94;95;94;94;94;94;94 13:10:52 INFO - PID 5067 | |8;json-parse-financial;45;48;46;45;45;51;45;45;44;44 13:10:52 INFO - PID 5067 | |9;json-stringify-tinderbox;39;38;38;38;39;40;41;39;39;39 13:10:52 INFO - PID 5067 | |10;stanford-crypto-aes;72;72;77;72;72;71;73;71;76;73 13:10:52 INFO - PID 5067 | |11;stanford-crypto-ccm;113;110;109;118;111;109;118;123;108;157 13:10:52 INFO - PID 5067 | |12;stanford-crypto-pbkdf2;156;155;158;159;161;151;170;165;150;147 13:10:52 INFO - PID 5067 | |13;stanford-crypto-sha256-iterative;59;59;61;61;63;59;58;58;58;57 13:10:52 INFO - PID 5067 | __end_tp_report 13:10:52 INFO - PID 5067 | __start_cc_report 13:10:52 INFO - PID 5067 | _x_x_mozilla_cycle_collect,883 13:10:52 INFO - PID 5067 | __end_cc_report 13:10:52 INFO - PID 5067 | __startTimestamp1504037452531__endTimestamp 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | ------- Summary: start ------- 13:10:52 INFO - PID 5067 | Number of tests: 14 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#0] ai-astar Cycles:10 Average:103.40 Median:108.00 stddev:4.65 (4.3%) stddev-sans-first:4.09 13:10:52 INFO - PID 5067 | Values: 96.0 105.0 99.0 106.0 106.0 106.0 108.0 96.0 104.0 108.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:143.00 stddev:22.58 (15.8%) stddev-sans-first:23.73 13:10:52 INFO - PID 5067 | Values: 146.0 112.0 145.0 176.0 114.0 140.0 141.0 118.0 167.0 115.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.95 (1.8%) stddev-sans-first:3.09 13:10:52 INFO - PID 5067 | Values: 162.0 163.0 163.0 161.0 161.0 163.0 162.0 161.0 170.0 167.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:10.49 (14.0%) stddev-sans-first:10.67 13:10:52 INFO - PID 5067 | Values: 72.0 73.0 73.0 101.0 76.0 73.0 80.0 88.0 95.0 74.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:78.00 stddev:23.33 (29.9%) stddev-sans-first:24.17 13:10:52 INFO - PID 5067 | Values: 78.0 78.0 126.0 78.0 77.0 77.0 126.0 78.0 78.0 126.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 13:10:52 INFO - PID 5067 | Values: 115.0 114.0 114.0 114.0 115.0 114.0 114.0 115.0 115.0 113.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:150.50 stddev:3.72 (2.5%) stddev-sans-first:3.91 13:10:52 INFO - PID 5067 | Values: 150.0 150.0 160.0 149.0 156.0 150.0 148.0 152.0 151.0 149.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 13:10:52 INFO - PID 5067 | Values: 93.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#8] json-parse-financial Cycles:10 Average:45.80 Median:45.00 stddev:2.15 (4.8%) stddev-sans-first:2.26 13:10:52 INFO - PID 5067 | Values: 45.0 48.0 46.0 45.0 45.0 51.0 45.0 45.0 44.0 44.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#9] json-stringify-tinderbox Cycles:10 Average:39.00 Median:39.00 stddev:0.94 (2.4%) stddev-sans-first:1.00 13:10:52 INFO - PID 5067 | Values: 39.0 38.0 38.0 38.0 39.0 40.0 41.0 39.0 39.0 39.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:72.50 stddev:2.02 (2.8%) stddev-sans-first:2.12 13:10:52 INFO - PID 5067 | Values: 72.0 72.0 77.0 72.0 72.0 71.0 73.0 71.0 76.0 73.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:115.50 stddev:14.70 (12.7%) stddev-sans-first:15.50 13:10:52 INFO - PID 5067 | Values: 113.0 110.0 109.0 118.0 111.0 109.0 118.0 123.0 108.0 157.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:158.50 stddev:7.02 (4.4%) stddev-sans-first:7.43 13:10:52 INFO - PID 5067 | Values: 156.0 155.0 158.0 159.0 161.0 151.0 170.0 165.0 150.0 147.0 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.30 Median:59.00 stddev:1.83 (3.1%) stddev-sans-first:1.94 13:10:52 INFO - PID 5067 | Values: 59.0 59.0 61.0 61.0 63.0 59.0 58.0 58.0 58.0 57.0 13:10:52 INFO - PID 5067 | -------- Summary: end -------- 13:10:52 INFO - PID 5067 | 13:10:52 INFO - PID 5067 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:10:53 INFO - TEST-INFO | 5067: exit 0 13:10:53 INFO - TEST-OK | kraken | took 59743ms 13:10:53 INFO - SUITE-END | took 1169s 13:10:53 INFO - Completed test suite (00:19:29) 13:10:53 INFO - javascript benchmark 13:10:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9254.4936205368, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3864.7874366909828, 3897.9025524361878, 3906.4335671327653, 3934.980325098374, 3938.0548668319593, 6810.421114205298, 6881.277465866087, 6892.414144797692, 6909.0, 6920.169579650449, 6752.831179220522, 6823.965880170605, 6833.794986150411, 6836.863262734742, 6893.724251029953, 6091.9390806091815, 6105.023196288595, 6133.6626485543275, 6136.202293701813, 6153.0, 6114.663693496856, 6134.6012509186985, 6142.631442113465, 6200.720967556471, 6215.036669316263, 6176.382361763833, 6226.190595222614, 6231.40801623845, 6231.5326350523665, 6297.811065668037, 6101.115338275969, 6175.660338681393, 6181.6600086995195, 6192.81421557354, 6235.750569977218, 5975.820725378246, 5980.282366116094, 6005.0, 6119.1739115219325, 6212.192414986068, 6750.662466876685, 6821.795346139624, 6866.141732283465, 6928.1339832520935, 6941.479389045791, 7306.232845551193, 7368.336849683555, 7371.594562299071, 7497.5126616770285, 7509.549427034395, 7465.29079737424, 7466.290702383265, 7536.284053014955, 7591.81020474487, 7597.088349398107, 6948.826279342956, 6978.337057979484, 7028.086348774677, 7037.296270372973, 7046.964765176142, 7666.923330766733, 7671.424643151786, 7684.6157692116285, 7697.999260096263, 7776.144624091346, 7146.106736657918, 7249.311315425026, 7395.334419902235, 7472.70109195637, 7485.25147485258, 7418.554886706815, 7470.626468676544, 7475.551466912003, 7542.962285188539, 7570.810729731801, 7336.669849856769, 7366.042414486083, 7397.667104980289, 7457.291557302047, 7541.057367829021, 7435.51669141504, 7440.218777028443, 7542.396608271325, 7542.811429714301, 7548.849023019508, 6271.184745982993, 6323.114763933053, 6371.840703982438, 6391.488680905516, 6406.903896441557, 5415.702136382458, 5483.369412517532, 5585.273914391184, 5586.525145362609, 5614.803481878196, 6202.41077097675, 6364.809055728336, 6366.204224471941, 6377.139086223393, 6446.709898054505, 7367.410607151415, 7367.4842761007285, 7377.0, 7459.664315105833, 7493.812654683567, 6359.650219237894, 6379.489640828722, 6440.710168042449, 6441.323661015525, 6445.871082578322, 6589.209294884645, 6669.833254168588, 6702.229243637044, 6759.087523184406, 6763.222229443677, 7201.747938822116, 7250.238724933912, 7250.347468727839, 7257.52826066304, 7263.527870688388, 7322.28543161019, 7337.963310183629, 7402.0, 7432.145303290191, 7437.219091995479, 7220.566765994057, 7247.782566523013, 7254.782356529313, 7265.12818461788, 7285.963570182115, 7319.5242309249725, 7345.155307139534, 7388.593627350548, 7395.630218488946, 7427.962860185665, 7290.635468226461, 7391.593462359622, 7394.112706475257, 7511.661975211238, 7518.0, 7163.212046674966, 7185.820354491179, 7188.137423509213, 7193.100862392201, 7193.388561972291, 7165.713371465292, 7167.820804479721, 7175.748848790267, 7201.279872012757, 7231.602261875437, 7180.31786980236, 7180.533265337736, 7189.137303523401, 7228.0, 7236.674349654173, 7156.785296441115, 7198.89201661965, 7261.673224704795, 7273.0908636420445, 7329.377002954595, 6941.34057264559, 6985.1617805863625, 7001.8249543759775, 7030.9296907030275, 7037.1555413350725], "value": 6796.540280206147, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [953.5184731710485, 968.4528241543527, 993.821112199804, 1021.7139201023716, 1021.7649940513681, 44653.0, 45227.32159017617, 45289.547104528945, 45320.77339613305, 45634.7718261409, 42300.57699423005, 42670.57329426705, 42785.57214427862, 42808.785956070176, 42836.78581607095, 7473.813154671149, 7581.3555847753005, 7584.544927304351, 7598.924010759904, 7602.6958921643345, 7493.962530187341, 7558.395328373745, 7560.848783024337, 7568.281013303755, 7568.318851303382, 7554.546727196358, 7578.9389485472075, 7587.696492140335, 7591.316781489665, 7594.468387212897, 7551.433642476809, 7573.7727868163765, 7581.166071732133, 7581.696732130708, 7582.658780354842, 6898.586084834876, 6967.0, 6968.756093536753, 6974.755883544051, 6976.058232138647, 36551.4517282241, 36764.63235367639, 36792.08019799527, 36793.0, 36828.079298017496, 3624.6194149614175, 3640.2719456108885, 3643.617420170897, 3646.6717995380545, 3646.9817650911577, 29618.0, 29796.70203297961, 29859.850700746574, 29886.0, 29917.850410748026, 4687.437507499122, 4934.1611925972675, 4938.678985865943, 4980.203167493184, 5015.3229314042865, 213154.99999999846, 215030.0, 215172.0, 215553.0, 215978.99999999843, 24988.500229995298, 25017.4996500069, 25022.249332520052, 25094.749052509607, 25124.0, 60521.39478605158, 60704.0, 60881.69559152176, 60886.0, 61257.69371153205, 16724.74912876308, 16992.660146796996, 17016.404425845038, 17028.744568831476, 17043.0, 13496.865031349756, 13660.11209271414, 13694.657633559042, 13746.175229486264, 13783.793243101361, 16107.275172617261, 16155.353785848669, 16208.51374458768, 16212.75680864788, 16227.0, 6119.816405507842, 6139.754409823647, 6187.288461826947, 6259.7496100156395, 6304.338044505353, 1101.6199411203122, 1108.7394462301352, 1113.1095123900848, 1113.9554417823197, 1129.6102844518628, 25423.0, 25461.3634659135, 25577.488450230892, 25656.102036428634, 25667.358316041875, 1211.4972286501004, 1227.4353797253364, 1234.1237721218035, 1242.465739731924, 1249.2941488059398, 13759.17444953306, 13767.0, 13779.379927903268, 18088.63822723538, 18159.27362905469, 288139.0, 288765.0, 289020.0, 289884.0, 290232.0, 59882.70058649766, 62326.68836655788, 62779.37220627735, 64773.0, 64958.35041649523, 1521.117751704009, 1552.154076028567, 1557.1746974103744, 1561.11796834788, 1563.5231254467496, 29638.70361296446, 29729.85135074311, 30147.0, 30610.0, 31179.0, 42783.14433711371, 42926.570734292254, 42948.35577466278, 42983.355249670654, 43081.353779692705, 250228.0, 250280.0, 250394.0, 251511.0, 251547.0, 37894.431583525715, 37988.20117988179, 38006.619933800306, 38052.23895522129, 38261.61738382692, 46565.76717116393, 47273.0, 47619.76190119166, 47775.76112119417, 48107.0, 34273.31453370869, 34424.82787586046, 36642.45036324404, 37532.81233593924, 38135.0, 36594.634053660186, 36605.0, 36717.816410917774, 36977.260454790216, 37147.62852371442, 42862.57137428711, 42928.0, 43167.35248971205, 43802.78098609487, 43861.0, 35140.29719405649, 35156.47265290972, 35178.120546985505, 35281.82359088188, 35310.47034294436, 25662.230133096036, 25833.483330333664, 26276.474470510864, 26445.206643800717, 26746.59880101761], "value": 18359.547519379696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.4730063893455, 600.147790138004, 604.5405491826216, 604.8356912942585, 619.4734475695658, 23251.534969300646, 23579.882100589493, 24334.269971900827, 24340.634890476656, 24342.513149736995, 26871.193864184104, 27128.728712712866, 27255.0, 27343.726562734366, 27356.31609209766, 6781.932180678179, 6920.031195632616, 6920.5847649141215, 6946.097007389032, 6949.791506254795, 6515.41361277485, 6757.358050985148, 6781.932180678204, 6787.592744435325, 6787.898181527281, 6741.696623651947, 6744.359285867835, 6745.696443660047, 6750.054992301082, 6751.459883209356, 6720.630365329905, 6729.6971636276485, 6731.730730770788, 6736.932630673679, 6741.59550426976, 6270.216222972129, 6276.717547710364, 6282.780102696383, 6286.811395658137, 6293.056041593752, 30003.249918751986, 30600.8469957651, 31504.684953150634, 31652.683473165205, 31662.525062124085, 2184.6067707812585, 2202.4714068623416, 2208.5251670890834, 2210.812080973119, 2212.5021870079263, 20279.5944081119, 20793.792062079337, 20793.792062079337, 20817.58364832695, 20941.0, 2492.626106084084, 2535.366158460385, 2578.406966397739, 2580.4452042810885, 2589.961150582743, 159413.20293398574, 162523.0, 162693.0, 162763.0, 162890.0, 15704.842951570567, 16157.353705851869, 16169.0, 16599.83400166007, 16847.0, 25587.87206063995, 25617.743822561908, 25644.974201032124, 25651.871740641178, 25712.0, 10618.1505479563, 10918.344899306067, 10936.835947460795, 10943.23397362193, 10958.506867190996, 8780.341474389446, 9129.360944733939, 9699.224062075016, 9966.20270378368, 10093.192544596415, 9872.0, 10213.0, 10245.385276883411, 10252.743681408025, 10265.486725663686, 2938.3241854373614, 2946.130891387046, 2948.498755211619, 2948.9852550737537, 3009.6990300970165, 1037.5434808684154, 1071.6195750508457, 1075.2795228944938, 1086.5708045322053, 1087.0705546757408, 21634.0, 21869.343919682437, 22209.44476388071, 22448.0, 22634.547309054054, 1078.6224821312478, 1130.6381957773433, 1146.4325159046325, 1149.7183190118308, 1151.6890439581434, 11743.88256117428, 11959.581414650445, 12029.759404811855, 12066.758664826655, 12286.938565307117, 638468.0, 650617.0, 654517.0, 672207.0, 673696.0, 133776.0, 139623.0, 139851.0, 142403.0, 143210.0, 1291.12203701482, 1293.7089154940252, 1322.9007824413206, 1323.6227675112548, 1325.1254172246272, 19471.318503852297, 19727.605447890674, 19769.70345444848, 19885.801141988395, 19914.50213744668, 61943.070853936326, 63658.68170659117, 64213.67893160504, 65538.0, 66682.0, 79604.60197698974, 80532.59733701294, 80700.0, 81429.0, 81567.0, 15448.613784655474, 15967.121808300655, 15970.68058638844, 15984.760228596813, 16015.839841601435, 24707.505849883262, 25084.874575627004, 25090.62364064577, 25140.74859251384, 26044.0, 20941.89529052345, 21059.0, 21082.78917210808, 21150.048247828578, 21163.68254476215, 17843.464696059138, 18951.0524473773, 19054.42836714901, 19159.0, 19231.615367692848, 21508.569828603653, 21800.236991705213, 21961.121555137615, 22078.22726204575, 22120.115195392005, 15744.685106298039, 15898.68202635964, 15939.8406015943, 15980.28088736033, 16127.758083628989, 20540.897295513427, 20611.38165855027, 20652.79347206509, 20676.379708608765, 20878.895605521877], "value": 13137.232808095134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.120927443534, 1528.892977491576, 1534.5473085439792, 1537.423466200175, 1544.1815837606073, 15955.0, 16605.33578656854, 16642.167891605433, 16647.66704665909, 17180.22688978996, 17448.389306374247, 17696.911515442436, 17703.0, 17725.468235952943, 17738.29046838125, 2866.527023041201, 2899.1592438192897, 2918.3141961639, 2919.343147791751, 2922.3862988772385, 2810.1148138336357, 2901.05715642416, 2902.62265905432, 2903.3467469819334, 2905.8837646494117, 2786.4984302825483, 2790.8185967912123, 2796.7622752065995, 2796.9021084262054, 2800.313923088846, 2806.564982427727, 2809.8314101153996, 2819.6334476518127, 2819.8590070496393, 2823.5623478360785, 2698.9595156072673, 2702.486527559757, 2719.809613327068, 2722.6460560127257, 2723.836569805818, 16246.75629865553, 16576.66846663072, 16593.83406165947, 16612.0, 16620.750688739678, 8357.582120893992, 8608.225259726592, 8617.095205003447, 8618.525981071038, 8646.092160323138, 5396.460353964611, 5520.1443776214755, 5612.579056570774, 5620.606557540974, 5622.718864056781, 2058.423641380416, 2088.1334246287774, 2096.643570593003, 2132.0, 2142.046789178816, 29493.557596636067, 29725.851370743007, 29727.25681857949, 29776.553351699742, 29790.0, 7190.496665233383, 7258.854822903512, 7297.489175757646, 7364.189939106694, 7426.777196684108, 18992.145353459127, 18994.905025474785, 18999.335023274118, 19026.904865475582, 19131.33040343581, 7533.698652053857, 8064.830599563148, 8073.83852322962, 8363.121872203332, 8538.573071346407, 6651.0, 6846.657667116724, 7331.266873312626, 7792.532448053135, 7949.880751788728, 5453.481919217668, 5636.897509138433, 5675.574331925122, 5727.599068065196, 5896.587238893322, 1621.4892308922651, 1634.942777002823, 1638.1399765123167, 1651.900885946847, 1653.1649868645793, 993.4089216915924, 1004.5228516454625, 1015.167562598662, 1019.7960407918446, 1033.2302434686208, 8652.307815374756, 8729.170728780755, 8825.735227943173, 8897.332700047393, 8907.421017633833, 744.8994385757961, 761.6268028665913, 772.2239149654673, 784.7253461288503, 792.7066985215507, 5023.723695196799, 5126.077306084866, 5619.719014049281, 5782.421757824184, 5859.326177489558, 24392.390190245387, 25115.246542603752, 25116.748832511443, 25137.62293565598, 25249.0, 23901.282961511184, 25285.367865803135, 25311.746882531308, 25350.492990140094, 25400.618990714785, 11554.133439992034, 12047.0, 12090.455929483194, 12096.81854772179, 12134.211276267015, 9507.619695212114, 9538.95230523843, 9801.950990245003, 9854.408735475894, 9934.403935763878, 20438.386848394573, 20487.999999999403, 20665.586688266452, 20751.584968300853, 21101.57796844085, 21810.781892180876, 21878.343649690534, 21990.0, 22112.44718882041, 22929.197478088186, 11200.887991120311, 11540.422978851191, 11599.478023489131, 12164.513419463123, 12428.067894907737, 14725.705485890436, 14779.334929927963, 14792.778108328168, 14798.6300342488, 14823.629409264855, 11532.94233528827, 11638.0, 11731.88268117308, 11758.823617645914, 12283.754324913272, 11792.823107653563, 11938.76122477563, 12069.818952715892, 12098.455569499569, 12129.514819407124, 10569.788604228026, 10624.096951759188, 10624.415657138932, 10671.816444357788, 10679.359238445719, 8052.718154864551, 8294.751157465285, 8314.916850831414, 8344.749657510285, 8429.452085614415, 8284.378671599534, 8433.283170930294, 8464.66141354339, 8590.0, 8661.740147795575], "value": 7192.57781735873, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.7461967494952, 562.77207730869, 576.250873863977, 576.971151442428, 580.817042631571, 6832.624205668686, 6855.828604284895, 6858.7942361729165, 6891.4831387646, 6922.584644921296, 6721.630310332942, 6753.223379311381, 6777.2545020047755, 6779.932200677992, 6806.319368063191, 5447.428020057896, 5472.20653005314, 5493.450654934514, 5517.586181036419, 5524.723763811813, 5158.406783219922, 5446.576273558268, 5502.257195278627, 5511.173324001412, 5540.0, 5240.764165612557, 5261.816091379447, 5274.709890955995, 5277.0, 5320.095583750753, 5256.237845512379, 5277.419483856773, 5278.973605131988, 5312.096943519611, 5319.308489896327, 4769.928451073237, 4778.757523043999, 4792.113459010059, 4794.760261986921, 4796.736179510125, 6616.503762217805, 6660.601273732522, 6666.799996000079, 6671.799846004627, 6672.899906501407, 6290.937090629081, 6292.150559674431, 6307.716152773136, 6313.210848643919, 6333.96833015832, 6986.755463558751, 7051.519180972002, 7056.894146587805, 7174.197675232135, 7198.676059577331, 5257.815976440845, 5278.577713782888, 5334.626576139672, 5347.732613369316, 5359.276497672803, 7118.501704880712, 7268.309510596485, 7350.301721336465, 7503.174650788409, 7545.924540754632, 5361.249425080492, 5372.952274306473, 5377.193420986883, 5426.131818908955, 5453.15476101205, 5506.394296627368, 5515.531179849758, 5521.116621340566, 5565.3304008797195, 5569.888602227933, 6196.349383314777, 6229.4393504583895, 6248.4064013918605, 6266.749330026748, 6277.905831412532, 7117.932310153415, 7150.284971502912, 7207.0, 7211.639418029077, 7220.74727384539, 1894.2612381171355, 1902.4482899959135, 1914.9712754308696, 1917.8465722742146, 1926.5280006398523, 1294.3851670456645, 1316.9341532923315, 1328.2296268164635, 1334.8998825088158, 1344.253939063829, 6101.96949015261, 6213.285472170668, 6235.971064774352, 6237.0, 6243.313235544087, 7056.788296351117, 7077.92922070783, 7136.928630713626, 7137.678804453812, 7209.459290553124, 6169.81490555284, 6212.627242365382, 6235.127082208494, 6255.6872156392, 6264.123022776815, 3815.3704638734853, 3819.3316169670197, 3833.290841194388, 3882.6893848492055, 3886.9222615548097, 7016.929830701628, 7027.43780497559, 7078.823029424306, 7138.9286107139305, 7165.247648996885, 7508.0, 7526.725874244721, 7533.962330188314, 7558.9244107558225, 7574.204708505527, 6929.0, 7067.89398159028, 7084.893726594105, 7100.502964792415, 7152.606606636685, 7216.458765592497, 7278.235785242473, 7295.489315748059, 7325.4872158948365, 7354.338109570164, 7155.141383034069, 7278.617062758059, 7361.521501102411, 7363.484556081023, 7368.0, 6946.479014074066, 6950.374466298057, 7045.753398631228, 7067.0, 7071.398931090915, 5365.0, 5366.382865970463, 5383.165609330404, 5398.892022159614, 5408.972955135199, 7175.0, 7306.926930730625, 7307.159676637255, 7344.265573442826, 7360.263973602597, 6706.631135287606, 6957.721691132298, 6976.267491913276, 7024.4029257513685, 7047.6123813188715, 6906.0, 6925.342092501204, 6928.549644273106, 6962.189830643968, 7074.858502829811, 6777.356151165632, 6836.316368363124, 6988.126484189476, 7029.789106326818, 7048.365647091787, 7031.753888613874, 7052.18899826506, 7085.681144348414, 7090.4327653788605, 7123.893141602984, 6810.897836532555, 6821.93178068213, 6897.965510172417, 6916.446684265146, 6992.300769922967], "value": 5482.381252543371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [959.7024922274096, 998.1116806042621, 1003.2375394700031, 1007.7883644434669, 1017.872765904262, 16593.585160370996, 17068.573285667866, 17116.828831711693, 17145.91427042866, 18667.533311667215, 18296.908515457406, 18298.542536436595, 18421.723674144898, 18469.81530184701, 18515.537111572183, 1076.8707755069402, 1105.9659218630607, 1106.435717783932, 1106.955721771128, 1107.7618312062905, 1045.6131231444376, 1078.9244752867303, 1088.9455527223647, 1089.3463921646987, 1090.2640717515685, 1153.948072336747, 1154.0133186125868, 1154.0709728668419, 1154.3477934966759, 1154.4227886056972, 1147.1625713229348, 1147.8852114788538, 1151.4645689754263, 1152.038048229725, 1152.130141742987, 847.9703210387669, 848.1645579104577, 849.7365816596874, 851.880736696863, 852.075498084579, 17289.394871179575, 17509.387171449067, 17509.737353939574, 17584.384546540936, 18019.72970405445, 19281.132349044186, 19353.80646193548, 19625.9018704907, 19983.700244496344, 19995.400137995883, 15447.30487128082, 15475.613109672237, 15612.219389030502, 15618.0, 15628.687426251525, 3800.1069748609057, 3891.1633998690136, 3891.9221615567812, 3893.2602805467154, 3894.1432884765304, 147588.99999999892, 148593.0, 149199.0, 149431.2528437351, 154121.0, 13778.793318100237, 14109.223992680501, 14150.433982640785, 14253.714925701428, 14266.714665706835, 28130.71869281281, 29659.55510667342, 29751.553726694117, 29986.0, 30002.0, 8528.488290702579, 8821.0, 9256.444613323221, 9449.952750236205, 9462.195713364303, 3939.1924655445564, 4068.2880495913096, 4151.522574903925, 4281.443412356373, 4479.126570318756, 4894.657373983858, 5025.7989680412375, 5039.4708555601865, 5043.36957880265, 5045.596352291808, 1111.8332250162541, 1132.9660110196708, 1142.9142814288962, 1147.3058799426394, 1147.4434899073942, 735.1472292141198, 760.6501009535565, 761.3680645064583, 780.574586850168, 786.6066966516742, 11852.762944741056, 12553.811692824615, 12562.309073001074, 13291.933540332237, 13314.134581252187, 752.1012390193666, 755.6675062972274, 758.9051368578928, 760.6462994707488, 769.7498313048281, 5741.827745167651, 5798.057321021662, 5809.535237181015, 6042.728077236535, 6061.030235162441, 135900.0, 135920.0, 136001.0, 140218.0, 142171.0, 122355.38822305831, 122359.0, 122829.0, 123468.0, 128927.35536322258, 97804.51097744466, 100722.49638751759, 102241.0, 105621.0, 106248.0, 13264.0, 13611.047226694433, 13785.724285514032, 13789.586312410644, 14016.579502614937, 47784.761076195784, 48199.0, 49256.50743492663, 49811.75094124506, 51142.74428627833, 78614.606926965, 80623.59688201756, 81353.0, 83001.0, 85787.57106214679, 18205.908970455064, 18215.635687286445, 18418.447446576625, 18544.350947716764, 18587.90706046461, 18788.624227515098, 19521.511962201057, 20110.39668809938, 20399.388018359474, 21838.344849654535, 20013.39959801208, 20517.692234616195, 20870.582588347843, 20961.475963100434, 21132.894335528224, 20823.271185508434, 20831.8958405207, 20980.0, 21035.8948205258, 21475.355739327846, 20356.389308320773, 20536.178552857717, 20655.981848803618, 20669.483262918548, 21006.579868402852, 13656.0, 14232.501862434765, 14408.0, 14812.851871481147, 14910.630995554917, 14482.565523034325, 14613.050151740103, 14628.707425851637, 14721.411143554138, 14765.114093154445], "value": 9718.182902032822, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 105.0, 99.0, 106.0, 106.0, 106.0, 108.0, 96.0, 104.0, 108.0], "value": 103.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 145.0, 176.0, 114.0, 140.0, 141.0, 118.0, 167.0, 115.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 161.0, 163.0, 162.0, 161.0, 170.0, 167.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 101.0, 76.0, 73.0, 80.0, 88.0, 95.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 126.0, 78.0, 77.0, 77.0, 126.0, 78.0, 78.0, 126.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 160.0, 149.0, 156.0, 150.0, 148.0, 152.0, 151.0, 149.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 48.0, 46.0, 45.0, 45.0, 51.0, 45.0, 45.0, 44.0, 44.0], "value": 45.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 40.0, 41.0, 39.0, 39.0, 39.0], "value": 39.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 77.0, 72.0, 72.0, 71.0, 73.0, 71.0, 76.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 109.0, 118.0, 111.0, 109.0, 118.0, 123.0, 108.0, 157.0], "value": 117.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 158.0, 159.0, 161.0, 151.0, 170.0, 165.0, 150.0, 147.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 61.0, 63.0, 59.0, 58.0, 58.0, 58.0, 57.0], "value": 59.3, "unit": "score"}]}]} 13:10:53 INFO - Return code: 0 13:10:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:10:53 INFO - # TBPL SUCCESS # 13:10:53 INFO - Running post-action listener: _package_coverage_data 13:10:53 INFO - Running post-action listener: _resource_record_post_action 13:10:53 INFO - [mozharness: 2017-08-29 20:10:53.318305Z] Finished run-tests step (success) 13:10:53 INFO - Running post-run listener: _resource_record_post_run 13:10:53 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 438272; Write bytes: 388235264; Read time: 264; Write time: 192084 13:10:53 INFO - TinderboxPrint: CPU usage
13.1% 13:10:53 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 264 13:10:53 INFO - TinderboxPrint: I/O write bytes / time
388,235,264 / 192,084 13:10:53 INFO - TinderboxPrint: CPU idle
8,220.5 (86.9%) 13:10:53 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 13:10:53 INFO - TinderboxPrint: Swap in / out
0 / 0 13:10:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120520704; Read time: 0; Write time: 84364 13:10:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:10:53 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 438272; Write bytes: 267714560; Read time: 264; Write time: 107720 13:10:53 INFO - Running post-run listener: _upload_blobber_files 13:10:53 INFO - Blob upload gear active. 13:10:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:10:53 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 13:10:53 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'] 13:10:53 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 13:10:54 INFO - (blobuploader) - INFO - Open directory for files ... 13:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:10:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:10:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:10:55 INFO - (blobuploader) - INFO - Done attempting. 13:10:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:10:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:10:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:11:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:02 INFO - (blobuploader) - INFO - Done attempting. 13:11:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:11:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:03 INFO - (blobuploader) - INFO - Done attempting. 13:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:11:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:11:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:11:04 INFO - (blobuploader) - INFO - Done attempting. 13:11:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:11:04 INFO - Return code: 0 13:11:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:11:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:11:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c54de091dfa2141afd94b0be91bb5c4e52c3a87a66f287af1273154811e2ce16258d45f9606e1d8110745f6480cd248a0797a0cad48c325a70f0af726fb2ffb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28581e9a5e1c3220e65148594d05de4a1836c1e077d6ba228482b873b595a13a83a76e74478d76d672e8c8416b5dd423085faa28c991adad10267fbb1f16b011", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae19d5c29c5e9ad80482af82b91d29d0dd7bd6c44d032e55e341ebb7d946dfb1ff4dc4944061c17db13d9cf4ab5e9df04abde7f1d0ec61c8d4e7b67ca28549d5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ade18dbc89e4002a397ae7fe11fdcdb94a20ef89fb260aab89eeba02e60fe9e9ec2ba71fa2ded8bcbaf62e11904ca1a825b3da0f2d51a0a4d5925245ef1eda81"} 13:11:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:11:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:11:04 INFO - Contents: 13:11:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c54de091dfa2141afd94b0be91bb5c4e52c3a87a66f287af1273154811e2ce16258d45f9606e1d8110745f6480cd248a0797a0cad48c325a70f0af726fb2ffb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28581e9a5e1c3220e65148594d05de4a1836c1e077d6ba228482b873b595a13a83a76e74478d76d672e8c8416b5dd423085faa28c991adad10267fbb1f16b011", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae19d5c29c5e9ad80482af82b91d29d0dd7bd6c44d032e55e341ebb7d946dfb1ff4dc4944061c17db13d9cf4ab5e9df04abde7f1d0ec61c8d4e7b67ca28549d5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ade18dbc89e4002a397ae7fe11fdcdb94a20ef89fb260aab89eeba02e60fe9e9ec2ba71fa2ded8bcbaf62e11904ca1a825b3da0f2d51a0a4d5925245ef1eda81"} 13:11:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:11:04 INFO - Copying logs to upload dir... 13:11:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:11:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.962209 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-29 13:11:04.394340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:04.402201) ========= 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=4300f881736b422476174874000001bc-1504036214.23745-602349572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c54de091dfa2141afd94b0be91bb5c4e52c3a87a66f287af1273154811e2ce16258d45f9606e1d8110745f6480cd248a0797a0cad48c325a70f0af726fb2ffb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28581e9a5e1c3220e65148594d05de4a1836c1e077d6ba228482b873b595a13a83a76e74478d76d672e8c8416b5dd423085faa28c991adad10267fbb1f16b011", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae19d5c29c5e9ad80482af82b91d29d0dd7bd6c44d032e55e341ebb7d946dfb1ff4dc4944061c17db13d9cf4ab5e9df04abde7f1d0ec61c8d4e7b67ca28549d5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ade18dbc89e4002a397ae7fe11fdcdb94a20ef89fb260aab89eeba02e60fe9e9ec2ba71fa2ded8bcbaf62e11904ca1a825b3da0f2d51a0a4d5925245ef1eda81"} build_url:https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011420 build_url: 'https://queue.taskcluster.net/v1/task/c5iznR3nTS6fHhaEfhjVAw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c54de091dfa2141afd94b0be91bb5c4e52c3a87a66f287af1273154811e2ce16258d45f9606e1d8110745f6480cd248a0797a0cad48c325a70f0af726fb2ffb", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28581e9a5e1c3220e65148594d05de4a1836c1e077d6ba228482b873b595a13a83a76e74478d76d672e8c8416b5dd423085faa28c991adad10267fbb1f16b011", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae19d5c29c5e9ad80482af82b91d29d0dd7bd6c44d032e55e341ebb7d946dfb1ff4dc4944061c17db13d9cf4ab5e9df04abde7f1d0ec61c8d4e7b67ca28549d5", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ade18dbc89e4002a397ae7fe11fdcdb94a20ef89fb260aab89eeba02e60fe9e9ec2ba71fa2ded8bcbaf62e11904ca1a825b3da0f2d51a0a4d5925245ef1eda81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:04.429023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:04.429332) ========= 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=4300f881736b422476174874000001bc-1504036214.23745-602349572 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-29 13:11:04.512236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 13:11:04.512549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-29 13:11:04.512852) ========= ========= Total master_lag: 0.10 =========