builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1504693195.86 results: success (0) revision: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:55.856670) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:55.857363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:55.860862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:55.880645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:55.881232) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 03:19:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-09-06 03:19:56 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:56.018002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:56.018325) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021107 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:56.067853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:56.068184) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e --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 c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e --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=9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 03:19:56,494 truncating revision to first 12 chars 2017-09-06 03:19:56,494 Setting DEBUG logging. 2017-09-06 03:19:56,494 attempt 1/10 2017-09-06 03:19:56,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6e59f1b2e27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 03:19:57,062 unpacking tar archive at: mozilla-central-c6e59f1b2e27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.947467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:57.031601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:57.034938) ========= script_repo_revision: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:57.035306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:57.035597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 03:19:57.048861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-06 03:19:57.049136) ========= /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=9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:19:57 INFO - MultiFileLogger online at 20170906 03:19:57 in /builds/slave/test 03:19:57 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 03:19:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:57 INFO - {'append_to_log': False, 03:19:57 INFO - 'base_work_dir': '/builds/slave/test', 03:19:57 INFO - 'blob_upload_branch': 'Firefox', 03:19:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:57 INFO - 'branch': 'Firefox', 03:19:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:57 INFO - 'code_coverage': False, 03:19:57 INFO - 'config_files': ('talos/linux_config.py',), 03:19:57 INFO - 'default_actions': ('clobber', 03:19:57 INFO - 'read-buildbot-config', 03:19:57 INFO - 'download-and-extract', 03:19:57 INFO - 'populate-webroot', 03:19:57 INFO - 'create-virtualenv', 03:19:57 INFO - 'install', 03:19:57 INFO - 'setup-mitmproxy', 03:19:57 INFO - 'run-tests'), 03:19:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:57 INFO - 'disable_ccov_upload': False, 03:19:57 INFO - 'disable_stylo': False, 03:19:57 INFO - 'download_minidump_stackwalk': True, 03:19:57 INFO - 'download_symbols': 'ondemand', 03:19:57 INFO - 'enable_stylo': False, 03:19:57 INFO - 'enable_webrender': False, 03:19:57 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:19:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:57 INFO - 'gecko_profile': False, 03:19:57 INFO - 'gecko_profile_interval': 0, 03:19:57 INFO - 'installer_path': 'installer.exe', 03:19:57 INFO - 'log_level': 'info', 03:19:57 INFO - 'log_name': 'talos', 03:19:57 INFO - 'log_to_console': True, 03:19:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:19:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:19:57 INFO - 'opt_config_files': (), 03:19:57 INFO - 'pip_index': False, 03:19:57 INFO - 'suite': 'dromaeojs-e10s', 03:19:57 INFO - 'system_bits': '32', 03:19:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:57 INFO - 'title': 'talos-linux64-ix-088', 03:19:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:57 INFO - 'use_talos_json': True, 03:19:57 INFO - 'verify': 'False', 03:19:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:57 INFO - 'work_dir': 'build'} 03:19:57 INFO - [mozharness: 2017-09-06 10:19:57.601447Z] Running clobber step. 03:19:57 INFO - Running pre-action listener: _resource_record_pre_action 03:19:57 INFO - Running main action method: clobber 03:19:57 INFO - rmtree: /builds/slave/test/build 03:19:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:58 INFO - Running post-action listener: _resource_record_post_action 03:19:58 INFO - [mozharness: 2017-09-06 10:19:58.671034Z] Finished clobber step (success) 03:19:58 INFO - [mozharness: 2017-09-06 10:19:58.671131Z] Running read-buildbot-config step. 03:19:58 INFO - Running pre-action listener: _resource_record_pre_action 03:19:58 INFO - Running main action method: read_buildbot_config 03:19:58 INFO - Using buildbot properties: 03:19:58 INFO - { 03:19:58 INFO - "project": "", 03:19:58 INFO - "product": "firefox", 03:19:58 INFO - "who": "archaeopteryx@coole-files.de", 03:19:58 INFO - "installer_path": "public/build/target.tar.bz2", 03:19:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:19:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:19:58 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:19:58 INFO - "stage_platform": "linux64-stylosequential", 03:19:58 INFO - "basedir": "/builds/slave/test", 03:19:58 INFO - "buildnumber": 190, 03:19:58 INFO - "platform": "ubuntu64_hw_styloseq", 03:19:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:19:58 INFO - "slavebuilddir": "test", 03:19:58 INFO - "taskId": "LZtcC5xpSQGlfPb7CWUmrg", 03:19:58 INFO - "branch": "mozilla-central", 03:19:58 INFO - "script_repo_revision": "production", 03:19:58 INFO - "revision": "c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e", 03:19:58 INFO - "slavename": "talos-linux64-ix-088", 03:19:58 INFO - "repo_path": "mozilla-central" 03:19:58 INFO - } 03:19:58 INFO - Finding installer, test and symbols from parent task. 03:19:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LZtcC5xpSQGlfPb7CWUmrg'}, attempt #1 03:19:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LZtcC5xpSQGlfPb7CWUmrg'}, attempt #1 03:19:59 INFO - Task dependencies: dt_5wMQwQieSp4r1UgpK9Q 03:19:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q'}, attempt #1 03:20:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:20:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json 03:20:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip 03:20:00 INFO - Running post-action listener: _resource_record_post_action 03:20:00 INFO - [mozharness: 2017-09-06 10:20:00.180401Z] Finished read-buildbot-config step (success) 03:20:00 INFO - [mozharness: 2017-09-06 10:20:00.180619Z] Running download-and-extract step. 03:20:00 INFO - Running pre-action listener: _resource_record_pre_action 03:20:00 INFO - Running main action method: download_and_extract 03:20:00 INFO - mkdir: /builds/slave/test/build/tests 03:20: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')]} 03:20:00 INFO - trying https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json 03:20:00 INFO - Downloading https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:20:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:20:00 INFO - Downloaded 989 bytes. 03:20:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:20:00 INFO - Using the following test package requirements: 03:20:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:20:00 INFO - u'common': [u'target.common.tests.zip'], 03:20:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:20:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:20:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:20:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:20:00 INFO - u'mozbase': [u'target.common.tests.zip'], 03:20:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:20:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:20:00 INFO - u'web-platform': [u'target.common.tests.zip', 03:20:00 INFO - u'target.web-platform.tests.tar.gz'], 03:20:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:20:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:20:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip 03:20:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:00 INFO - Fetch https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip into memory 03:20:01 INFO - Content-Length response header: 55020032 03:20:01 INFO - Bytes received: 55020032 03:20:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:20:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip 03:20:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:20:12 INFO - Fetch https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip into memory 03:20:13 INFO - Content-Length response header: 55020032 03:20:13 INFO - Bytes received: 55020032 03:20:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.talos.tests.zip 03:20:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:20:25 INFO - Fetch https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.talos.tests.zip into memory 03:20:26 INFO - Content-Length response header: 14496665 03:20:26 INFO - Bytes received: 14496665 03:20:26 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')]} 03:20:26 INFO - trying https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:20:26 INFO - Downloading https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:20:28 INFO - Downloaded 62781728 bytes. 03:20:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:20:28 INFO - mkdir: /builds/slave/test/properties 03:20:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:20:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:20:28 INFO - Contents: 03:20:28 INFO - build_url:https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:20:28 INFO - Running post-action listener: _resource_record_post_action 03:20:28 INFO - Running post-action listener: find_tests_for_verification 03:20:28 INFO - Running post-action listener: set_extra_try_arguments 03:20:28 INFO - [mozharness: 2017-09-06 10:20:28.071396Z] Finished download-and-extract step (success) 03:20:28 INFO - [mozharness: 2017-09-06 10:20:28.071494Z] Running populate-webroot step. 03:20:28 INFO - Running pre-action listener: _resource_record_pre_action 03:20:28 INFO - Running main action method: populate_webroot 03:20:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:20:28 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['tresize', 03:20:28 INFO - 'tcanvasmark']}, 03:20:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:20:28 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['dromaeo_css', 03:20:28 INFO - 'kraken']}, 03:20:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:28 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:20:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'tests': ['damp', 'tps']}, 03:20:28 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['damp', 'tps']}, 03:20:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:20:28 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['dromaeo_dom']}, 03:20:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:20:28 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['basic_compositor_video', 03:20:28 INFO - 'glvideo']}, 03:20:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:20:28 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['ts_paint_webext', 03:20:28 INFO - 'tp5o_webext']}, 03:20:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:20:28 INFO - 'ts_paint', 03:20:28 INFO - 'tpaint', 03:20:28 INFO - 'sessionrestore', 03:20:28 INFO - 'sessionrestore_many_windows', 03:20:28 INFO - 'sessionrestore_no_auto_restore', 03:20:28 INFO - 'tabpaint']}, 03:20:28 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['a11yr', 03:20:28 INFO - 'ts_paint', 03:20:28 INFO - 'tpaint', 03:20:28 INFO - 'sessionrestore', 03:20:28 INFO - 'sessionrestore_many_windows', 03:20:28 INFO - 'sessionrestore_no_auto_restore', 03:20:28 INFO - 'tabpaint']}, 03:20:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:20:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:20:28 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['bloom_basic_singleton']}, 03:20:28 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['bloom_basic']}, 03:20:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:20:28 INFO - 'tsvgr_opacity', 03:20:28 INFO - 'tart', 03:20:28 INFO - 'tscrollx', 03:20:28 INFO - 'tsvg_static']}, 03:20:28 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['tsvgx', 03:20:28 INFO - 'tsvgr_opacity', 03:20:28 INFO - 'tart', 03:20:28 INFO - 'tscrollx', 03:20:28 INFO - 'tsvg_static']}, 03:20:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:20:28 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'talos_options': ['--disable-stylo'], 03:20:28 INFO - 'tests': ['tp5o']}, 03:20:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:28 INFO - 'talos_options': ['--mitmproxy', 03:20:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:28 INFO - '--firstNonBlankPaint'], 03:20:28 INFO - 'tests': ['tp6_google', 03:20:28 INFO - 'tp6_youtube', 03:20:28 INFO - 'tp6_amazon', 03:20:28 INFO - 'tp6_facebook']}, 03:20:28 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:28 INFO - 'talos_options': ['--disable-stylo', 03:20:28 INFO - '--mitmproxy', 03:20:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:28 INFO - '--firstNonBlankPaint'], 03:20:28 INFO - 'tests': ['tp6_google', 03:20:28 INFO - 'tp6_youtube', 03:20:28 INFO - 'tp6_amazon', 03:20:28 INFO - 'tp6_facebook']}, 03:20:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:20:28 INFO - 'talos_options': ['--stylo-threads=1', 03:20:28 INFO - '--mitmproxy', 03:20:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:20:28 INFO - '--firstNonBlankPaint'], 03:20:28 INFO - 'tests': ['tp6_google', 03:20:28 INFO - 'tp6_youtube', 03:20:28 INFO - 'tp6_amazon', 03:20:28 INFO - 'tp6_facebook']}, 03:20:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'talos_options': ['--xperf_path', 03:20:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:28 INFO - 'tests': ['tp5n']}, 03:20:28 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:20:28 INFO - 'talos_options': ['--disable-stylo', 03:20:28 INFO - '--xperf_path', 03:20:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:20:28 INFO - 'tests': ['tp5n']}}} 03:20:28 INFO - Running post-action listener: _resource_record_post_action 03:20:28 INFO - [mozharness: 2017-09-06 10:20:28.086426Z] Finished populate-webroot step (success) 03:20:28 INFO - [mozharness: 2017-09-06 10:20:28.086516Z] Running create-virtualenv step. 03:20:28 INFO - Running pre-action listener: _resource_record_pre_action 03:20:28 INFO - Running main action method: create_virtualenv 03:20:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:20:28 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:20:28 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:20:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:20:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:20:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:20:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:20:28 INFO - Installing pip...............done. 03:20:28 INFO - Return code: 0 03:20:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:20:29 INFO - Reading from file tmpfile_stdout 03:20:29 INFO - Output received: 03:20:29 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:20:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:20:29 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')]} 03:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:29 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')]} 03:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:29 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:29 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 03:20:29 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 03:20:29 INFO - Using env: {'DISPLAY': ':0', 03:20:29 INFO - 'HOME': '/home/cltbld', 03:20:29 INFO - 'LANG': 'en_US.UTF-8', 03:20:29 INFO - 'LANGUAGE': 'en_US:en', 03:20:29 INFO - 'LOGNAME': 'cltbld', 03:20:29 INFO - 'MAIL': '/var/mail/cltbld', 03:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:29 INFO - 'MOZ_NO_REMOTE': '1', 03:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:29 INFO - 'NO_EM_RESTART': '1', 03:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:29 INFO - 'PWD': '/builds/slave/test', 03:20:29 INFO - 'SHELL': '/bin/bash', 03:20:29 INFO - 'SHLVL': '1', 03:20:29 INFO - 'TERM': 'linux', 03:20:29 INFO - 'TMOUT': '86400', 03:20:29 INFO - 'USER': 'cltbld', 03:20:29 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:29 INFO - '_': '/tools/buildbot/bin/python'} 03:20:30 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:20:30 INFO - Downloading/unpacking pip>=1.5 03:20:30 INFO - Running setup.py egg_info for package pip 03:20:30 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:30 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:30 INFO - Installing collected packages: pip 03:20:30 INFO - Found existing installation: pip 1.1 03:20:30 INFO - Uninstalling pip: 03:20:30 INFO - Successfully uninstalled pip 03:20:30 INFO - Running setup.py install for pip 03:20:30 INFO - warning: no files found matching 'pip/cacert.pem' 03:20:30 INFO - warning: no files found matching '*.html' under directory 'docs' 03:20:30 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:20:30 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:20:30 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:20:30 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:20:30 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:20:30 INFO - Successfully installed pip 03:20:30 INFO - Cleaning up... 03:20:30 INFO - Return code: 0 03:20:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:20:30 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')]} 03:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:30 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')]} 03:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:30 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:30 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 03:20:30 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 03:20:30 INFO - Using env: {'DISPLAY': ':0', 03:20:30 INFO - 'HOME': '/home/cltbld', 03:20:30 INFO - 'LANG': 'en_US.UTF-8', 03:20:30 INFO - 'LANGUAGE': 'en_US:en', 03:20:30 INFO - 'LOGNAME': 'cltbld', 03:20:30 INFO - 'MAIL': '/var/mail/cltbld', 03:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:30 INFO - 'MOZ_NO_REMOTE': '1', 03:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:30 INFO - 'NO_EM_RESTART': '1', 03:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:30 INFO - 'PWD': '/builds/slave/test', 03:20:30 INFO - 'SHELL': '/bin/bash', 03:20:30 INFO - 'SHLVL': '1', 03:20:30 INFO - 'TERM': 'linux', 03:20:30 INFO - 'TMOUT': '86400', 03:20:30 INFO - 'USER': 'cltbld', 03:20:30 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:30 INFO - '_': '/tools/buildbot/bin/python'} 03:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:30 INFO - Downloading/unpacking psutil>=3.1.1 03:20:30 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 03:20:30 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 03:20:30 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 03:20:30 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 03:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:20:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:31 INFO - Installing collected packages: psutil 03:20:31 INFO - Running setup.py install for psutil 03:20:31 INFO - building 'psutil._psutil_linux' extension 03:20:31 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 03:20:31 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 03:20:31 INFO - building 'psutil._psutil_posix' extension 03:20:31 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 03:20:32 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 03:20:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:20:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:20:32 INFO - Successfully installed psutil 03:20:32 INFO - Cleaning up... 03:20:32 INFO - Return code: 0 03:20:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:20:32 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')]} 03:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:32 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')]} 03:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:32 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:32 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 03:20:32 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 03:20:32 INFO - Using env: {'DISPLAY': ':0', 03:20:32 INFO - 'HOME': '/home/cltbld', 03:20:32 INFO - 'LANG': 'en_US.UTF-8', 03:20:32 INFO - 'LANGUAGE': 'en_US:en', 03:20:32 INFO - 'LOGNAME': 'cltbld', 03:20:32 INFO - 'MAIL': '/var/mail/cltbld', 03:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:32 INFO - 'MOZ_NO_REMOTE': '1', 03:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:32 INFO - 'NO_EM_RESTART': '1', 03:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:32 INFO - 'PWD': '/builds/slave/test', 03:20:32 INFO - 'SHELL': '/bin/bash', 03:20:32 INFO - 'SHLVL': '1', 03:20:32 INFO - 'TERM': 'linux', 03:20:32 INFO - 'TMOUT': '86400', 03:20:32 INFO - 'USER': 'cltbld', 03:20:32 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:32 INFO - '_': '/tools/buildbot/bin/python'} 03:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:20:32 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 03:20:32 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 03:20:32 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 03:20:32 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 03:20:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:20:33 INFO - Installing collected packages: mozsystemmonitor 03:20:33 INFO - Running setup.py install for mozsystemmonitor 03:20:33 INFO - Successfully installed mozsystemmonitor 03:20:33 INFO - Cleaning up... 03:20:33 INFO - Return code: 0 03:20:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:20:33 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')]} 03:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:33 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')]} 03:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:33 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:33 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 03:20:33 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 03:20:33 INFO - Using env: {'DISPLAY': ':0', 03:20:33 INFO - 'HOME': '/home/cltbld', 03:20:33 INFO - 'LANG': 'en_US.UTF-8', 03:20:33 INFO - 'LANGUAGE': 'en_US:en', 03:20:33 INFO - 'LOGNAME': 'cltbld', 03:20:33 INFO - 'MAIL': '/var/mail/cltbld', 03:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:33 INFO - 'MOZ_NO_REMOTE': '1', 03:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:33 INFO - 'NO_EM_RESTART': '1', 03:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:33 INFO - 'PWD': '/builds/slave/test', 03:20:33 INFO - 'SHELL': '/bin/bash', 03:20:33 INFO - 'SHLVL': '1', 03:20:33 INFO - 'TERM': 'linux', 03:20:33 INFO - 'TMOUT': '86400', 03:20:33 INFO - 'USER': 'cltbld', 03:20:33 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:33 INFO - '_': '/tools/buildbot/bin/python'} 03:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:20:33 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 03:20:33 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 03:20:33 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 03:20:33 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 03:20:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20:35 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 03:20:35 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 03:20:35 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 03:20:35 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 03:20:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:35 INFO - warning: no files found matching '*.txt' 03:20:35 INFO - no previously-included directories found matching 'build' 03:20:35 INFO - no previously-included directories found matching 'dist' 03:20:35 INFO - no previously-included directories found matching '.git*' 03:20:35 INFO - Installing collected packages: jsonschema, functools32 03:20:35 INFO - Running setup.py install for functools32 03:20:35 INFO - warning: no files found matching '*.txt' 03:20:35 INFO - no previously-included directories found matching 'build' 03:20:35 INFO - no previously-included directories found matching 'dist' 03:20:35 INFO - no previously-included directories found matching '.git*' 03:20:35 INFO - Successfully installed jsonschema functools32 03:20:35 INFO - Cleaning up... 03:20:35 INFO - Return code: 0 03:20:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:35 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')]} 03:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:35 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')]} 03:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:35 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:35 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 03:20:35 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 03:20:35 INFO - Using env: {'DISPLAY': ':0', 03:20:35 INFO - 'HOME': '/home/cltbld', 03:20:35 INFO - 'LANG': 'en_US.UTF-8', 03:20:35 INFO - 'LANGUAGE': 'en_US:en', 03:20:35 INFO - 'LOGNAME': 'cltbld', 03:20:35 INFO - 'MAIL': '/var/mail/cltbld', 03:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:35 INFO - 'MOZ_NO_REMOTE': '1', 03:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:35 INFO - 'NO_EM_RESTART': '1', 03:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:35 INFO - 'PWD': '/builds/slave/test', 03:20:35 INFO - 'SHELL': '/bin/bash', 03:20:35 INFO - 'SHLVL': '1', 03:20:35 INFO - 'TERM': 'linux', 03:20:35 INFO - 'TMOUT': '86400', 03:20:35 INFO - 'USER': 'cltbld', 03:20:35 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:35 INFO - '_': '/tools/buildbot/bin/python'} 03:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:35 INFO - Cleaning up... 03:20:35 INFO - Return code: 0 03:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:35 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')]} 03:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:35 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')]} 03:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:35 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:35 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 03:20:35 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 03:20:35 INFO - Using env: {'DISPLAY': ':0', 03:20:35 INFO - 'HOME': '/home/cltbld', 03:20:35 INFO - 'LANG': 'en_US.UTF-8', 03:20:35 INFO - 'LANGUAGE': 'en_US:en', 03:20:35 INFO - 'LOGNAME': 'cltbld', 03:20:35 INFO - 'MAIL': '/var/mail/cltbld', 03:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:35 INFO - 'MOZ_NO_REMOTE': '1', 03:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:35 INFO - 'NO_EM_RESTART': '1', 03:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:35 INFO - 'PWD': '/builds/slave/test', 03:20:35 INFO - 'SHELL': '/bin/bash', 03:20:35 INFO - 'SHLVL': '1', 03:20:35 INFO - 'TERM': 'linux', 03:20:35 INFO - 'TMOUT': '86400', 03:20:35 INFO - 'USER': 'cltbld', 03:20:35 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:35 INFO - '_': '/tools/buildbot/bin/python'} 03:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:35 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 03:20:35 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 03:20:35 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 03:20:35 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 03:20:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:37 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 03:20:37 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 03:20:37 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 03:20:37 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 03:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:37 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 03:20:37 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 03:20:37 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 03:20:37 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 03:20:37 INFO - Downloading docopt-0.6.1.tar.gz 03:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:37 INFO - Running setup.py install for blobuploader 03:20:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:37 INFO - Running setup.py install for requests 03:20:37 INFO - Running setup.py install for docopt 03:20:38 INFO - Successfully installed blobuploader requests docopt 03:20:38 INFO - Cleaning up... 03:20:38 INFO - Return code: 0 03:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:38 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')]} 03:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:38 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')]} 03:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:38 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:38 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 03:20:38 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 03:20:38 INFO - Using env: {'DISPLAY': ':0', 03:20:38 INFO - 'HOME': '/home/cltbld', 03:20:38 INFO - 'LANG': 'en_US.UTF-8', 03:20:38 INFO - 'LANGUAGE': 'en_US:en', 03:20:38 INFO - 'LOGNAME': 'cltbld', 03:20:38 INFO - 'MAIL': '/var/mail/cltbld', 03:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:38 INFO - 'MOZ_NO_REMOTE': '1', 03:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:38 INFO - 'NO_EM_RESTART': '1', 03:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:38 INFO - 'PWD': '/builds/slave/test', 03:20:38 INFO - 'SHELL': '/bin/bash', 03:20:38 INFO - 'SHLVL': '1', 03:20:38 INFO - 'TERM': 'linux', 03:20:38 INFO - 'TMOUT': '86400', 03:20:38 INFO - 'USER': 'cltbld', 03:20:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:38 INFO - '_': '/tools/buildbot/bin/python'} 03:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:38 INFO - Running setup.py (path:/tmp/pip-hc92jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:38 INFO - Running setup.py (path:/tmp/pip-dHwpOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:38 INFO - Running setup.py (path:/tmp/pip-pKcx6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:38 INFO - Running setup.py (path:/tmp/pip-csgjHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:38 INFO - Running setup.py (path:/tmp/pip-LM4psb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:38 INFO - Running setup.py (path:/tmp/pip-Xi2Xmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:38 INFO - Running setup.py (path:/tmp/pip-SNDeVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:38 INFO - Running setup.py (path:/tmp/pip-R2D_Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:38 INFO - Running setup.py (path:/tmp/pip-Eu86WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:38 INFO - Running setup.py (path:/tmp/pip-iHW1em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:39 INFO - Running setup.py (path:/tmp/pip-HNdaJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:39 INFO - Running setup.py (path:/tmp/pip-tLaHBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:39 INFO - Running setup.py (path:/tmp/pip-gbYKMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:39 INFO - Running setup.py (path:/tmp/pip-iPmpkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:39 INFO - Running setup.py (path:/tmp/pip-LNCX_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:39 INFO - Running setup.py (path:/tmp/pip-xY_tLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:39 INFO - Running setup.py (path:/tmp/pip-nhvbTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:39 INFO - Running setup.py install for manifestparser 03:20:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozcrash 03:20:39 INFO - Running setup.py install for mozdebug 03:20:39 INFO - Running setup.py install for mozdevice 03:20:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:39 INFO - Running setup.py install for mozfile 03:20:40 INFO - Running setup.py install for mozhttpd 03:20:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for mozinfo 03:20:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for mozInstall 03:20:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for mozleak 03:20:40 INFO - Running setup.py install for mozlog 03:20:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for moznetwork 03:20:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for mozprocess 03:20:40 INFO - Running setup.py install for mozprofile 03:20:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for mozrunner 03:20:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:40 INFO - Running setup.py install for mozscreenshot 03:20:41 INFO - Running setup.py install for moztest 03:20:41 INFO - Running setup.py install for mozversion 03:20:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:41 INFO - Cleaning up... 03:20:41 INFO - Return code: 0 03:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:41 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')]} 03:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:41 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')]} 03:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:41 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:41 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 03:20:41 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 03:20:41 INFO - Using env: {'DISPLAY': ':0', 03:20:41 INFO - 'HOME': '/home/cltbld', 03:20:41 INFO - 'LANG': 'en_US.UTF-8', 03:20:41 INFO - 'LANGUAGE': 'en_US:en', 03:20:41 INFO - 'LOGNAME': 'cltbld', 03:20:41 INFO - 'MAIL': '/var/mail/cltbld', 03:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:41 INFO - 'MOZ_NO_REMOTE': '1', 03:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:41 INFO - 'NO_EM_RESTART': '1', 03:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:41 INFO - 'PWD': '/builds/slave/test', 03:20:41 INFO - 'SHELL': '/bin/bash', 03:20:41 INFO - 'SHLVL': '1', 03:20:41 INFO - 'TERM': 'linux', 03:20:41 INFO - 'TMOUT': '86400', 03:20:41 INFO - 'USER': 'cltbld', 03:20:41 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:41 INFO - '_': '/tools/buildbot/bin/python'} 03:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:41 INFO - Running setup.py (path:/tmp/pip-zhBBmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:41 INFO - Running setup.py (path:/tmp/pip-wJV_39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:41 INFO - Running setup.py (path:/tmp/pip-ulV2hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:41 INFO - Running setup.py (path:/tmp/pip-Bb4XL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:41 INFO - Running setup.py (path:/tmp/pip-fTPcPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:41 INFO - Running setup.py (path:/tmp/pip-Qh9u1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:41 INFO - Running setup.py (path:/tmp/pip-RLj5No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:41 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)) 03:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:41 INFO - Running setup.py (path:/tmp/pip-eFCeU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:42 INFO - Running setup.py (path:/tmp/pip-wQNpF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:42 INFO - Running setup.py (path:/tmp/pip-dtxJ0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:42 INFO - Running setup.py (path:/tmp/pip-fc8dX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:42 INFO - Running setup.py (path:/tmp/pip-uqXhD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:42 INFO - Running setup.py (path:/tmp/pip-NHHz7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:42 INFO - Running setup.py (path:/tmp/pip-N2ncMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:42 INFO - Running setup.py (path:/tmp/pip-uLPji3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:42 INFO - Running setup.py (path:/tmp/pip-FuUgj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:42 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)) 03:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:42 INFO - Running setup.py (path:/tmp/pip-FxU8FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:42 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)) 03:20:42 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)) 03:20:42 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)) 03:20:42 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)) 03:20:42 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)) 03:20:42 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)) 03:20:42 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)) 03:20:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:43 INFO - Downloading blessings-1.6.tar.gz 03:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:43 INFO - Installing collected packages: blessings 03:20:43 INFO - Running setup.py install for blessings 03:20:43 INFO - Successfully installed blessings 03:20:43 INFO - Cleaning up... 03:20:44 INFO - Return code: 0 03:20:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:44 INFO - Reading from file tmpfile_stdout 03:20:44 INFO - Current package versions: 03:20:44 INFO - argparse == 1.2.1 03:20:44 INFO - blessings == 1.6 03:20:44 INFO - blobuploader == 1.2.4 03:20:44 INFO - docopt == 0.6.1 03:20:44 INFO - functools32 == 3.2.3-2 03:20:44 INFO - jsonschema == 2.5.1 03:20:44 INFO - manifestparser == 1.1 03:20:44 INFO - mozInstall == 1.13 03:20:44 INFO - mozcrash == 1.0 03:20:44 INFO - mozdebug == 0.1 03:20:44 INFO - mozdevice == 0.51 03:20:44 INFO - mozfile == 1.2 03:20:44 INFO - mozhttpd == 0.7 03:20:44 INFO - mozinfo == 0.10 03:20:44 INFO - mozleak == 0.1 03:20:44 INFO - mozlog == 3.5 03:20:44 INFO - moznetwork == 0.27 03:20:44 INFO - mozprocess == 0.25 03:20:44 INFO - mozprofile == 0.28 03:20:44 INFO - mozrunner == 6.13 03:20:44 INFO - mozscreenshot == 0.1 03:20:44 INFO - mozsystemmonitor == 0.3 03:20:44 INFO - moztest == 0.8 03:20:44 INFO - mozversion == 1.4 03:20:44 INFO - psutil == 3.1.1 03:20:44 INFO - requests == 1.2.3 03:20:44 INFO - wsgiref == 0.1.2 03:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:44 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:44 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 03:20:44 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 03:20:44 INFO - Using env: {'DISPLAY': ':0', 03:20:44 INFO - 'HOME': '/home/cltbld', 03:20:44 INFO - 'LANG': 'en_US.UTF-8', 03:20:44 INFO - 'LANGUAGE': 'en_US:en', 03:20:44 INFO - 'LOGNAME': 'cltbld', 03:20:44 INFO - 'MAIL': '/var/mail/cltbld', 03:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:44 INFO - 'MOZ_NO_REMOTE': '1', 03:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:44 INFO - 'NO_EM_RESTART': '1', 03:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:44 INFO - 'PWD': '/builds/slave/test', 03:20:44 INFO - 'SHELL': '/bin/bash', 03:20:44 INFO - 'SHLVL': '1', 03:20:44 INFO - 'TERM': 'linux', 03:20:44 INFO - 'TMOUT': '86400', 03:20:44 INFO - 'USER': 'cltbld', 03:20:44 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:44 INFO - '_': '/tools/buildbot/bin/python'} 03:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 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)) 03:20:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:20:45 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)) 03:20:45 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)) 03:20:45 INFO - Installing collected packages: simplejson 03:20:45 INFO - Running setup.py install for simplejson 03:20:45 INFO - building 'simplejson._speedups' extension 03:20:45 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 03:20:46 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 03:20:46 INFO - Successfully installed simplejson 03:20:46 INFO - Cleaning up... 03:20:46 INFO - Return code: 0 03:20:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:46 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 0x201f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, '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': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', '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 03:20:46 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 03:20:46 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 03:20:46 INFO - Using env: {'DISPLAY': ':0', 03:20:46 INFO - 'HOME': '/home/cltbld', 03:20:46 INFO - 'LANG': 'en_US.UTF-8', 03:20:46 INFO - 'LANGUAGE': 'en_US:en', 03:20:46 INFO - 'LOGNAME': 'cltbld', 03:20:46 INFO - 'MAIL': '/var/mail/cltbld', 03:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:46 INFO - 'MOZ_NO_REMOTE': '1', 03:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:46 INFO - 'NO_EM_RESTART': '1', 03:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:46 INFO - 'PWD': '/builds/slave/test', 03:20:46 INFO - 'SHELL': '/bin/bash', 03:20:46 INFO - 'SHLVL': '1', 03:20:46 INFO - 'TERM': 'linux', 03:20:46 INFO - 'TMOUT': '86400', 03:20:46 INFO - 'USER': 'cltbld', 03:20:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:46 INFO - '_': '/tools/buildbot/bin/python'} 03:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:46 INFO - Cleaning up... 03:20:46 INFO - Return code: 0 03:20:46 INFO - Running post-action listener: _resource_record_post_action 03:20:46 INFO - Running post-action listener: _start_resource_monitoring 03:20:46 INFO - Starting resource monitoring. 03:20:46 INFO - [mozharness: 2017-09-06 10:20:46.954598Z] Finished create-virtualenv step (success) 03:20:46 INFO - [mozharness: 2017-09-06 10:20:46.955065Z] Running install step. 03:20:46 INFO - Running pre-action listener: _resource_record_pre_action 03:20:46 INFO - Running main action method: install 03:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:47 INFO - Reading from file tmpfile_stdout 03:20:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:47 INFO - Reading from file tmpfile_stdout 03:20:47 INFO - Output received: 03:20:47 INFO - Usage: mozinstall [options] installer 03:20:47 INFO - Options: 03:20:47 INFO - -h, --help show this help message and exit 03:20:47 INFO - -d DEST, --destination=DEST 03:20:47 INFO - Directory to install application into. [default: 03:20:47 INFO - "/builds/slave/test"] 03:20:47 INFO - --app=APP Application being installed. [default: firefox] 03:20:47 INFO - mkdir: /builds/slave/test/build/application 03:20:47 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'] 03:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:21:03 INFO - Reading from file tmpfile_stdout 03:21:03 INFO - Output received: 03:21:03 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:03 INFO - Running post-action listener: _resource_record_post_action 03:21:03 INFO - [mozharness: 2017-09-06 10:21:03.834150Z] Finished install step (success) 03:21:03 INFO - [mozharness: 2017-09-06 10:21:03.834402Z] Running setup-mitmproxy step. 03:21:03 INFO - Running pre-action listener: _resource_record_pre_action 03:21:03 INFO - Running main action method: setup_mitmproxy 03:21:03 INFO - Skipping: mitmproxy is not required 03:21:03 INFO - Running post-action listener: _resource_record_post_action 03:21:03 INFO - [mozharness: 2017-09-06 10:21:03.835539Z] Finished setup-mitmproxy step (success) 03:21:03 INFO - [mozharness: 2017-09-06 10:21:03.835758Z] Running run-tests step. 03:21:03 INFO - Running pre-action listener: _resource_record_pre_action 03:21:03 INFO - Running pre-action listener: _set_gcov_prefix 03:21:03 INFO - Running main action method: run_tests 03:21:03 WARNING - Try message not found. 03:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:03 INFO - Python 2.7.3 03:21:03 INFO - Return code: 0 03:21:03 INFO - grabbing minidump binary from tooltool 03:21: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')]} 03:21:03 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 0x238f090>, '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 0x238fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2389f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:03 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 03:21:03 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 03:21:03 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 03:21:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:03 INFO - Return code: 0 03:21:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:03 INFO - ENV: RUST_BACKTRACE is now full 03:21:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:03 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/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 03:21:03 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/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 03:21:03 INFO - Using env: {'DISPLAY': ':0', 03:21:03 INFO - 'HOME': '/home/cltbld', 03:21:03 INFO - 'LANG': 'en_US.UTF-8', 03:21:03 INFO - 'LANGUAGE': 'en_US:en', 03:21:03 INFO - 'LOGNAME': 'cltbld', 03:21:03 INFO - 'MAIL': '/var/mail/cltbld', 03:21:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:03 INFO - 'MOZ_NO_REMOTE': '1', 03:21:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:03 INFO - 'NO_EM_RESTART': '1', 03:21:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:03 INFO - 'PWD': '/builds/slave/test', 03:21:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:03 INFO - 'RUST_BACKTRACE': 'full', 03:21:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:03 INFO - 'SHELL': '/bin/bash', 03:21:03 INFO - 'SHLVL': '1', 03:21:03 INFO - 'STYLO_FORCE_ENABLED': '1', 03:21:03 INFO - 'STYLO_THREADS': '1', 03:21:03 INFO - 'TERM': 'linux', 03:21:03 INFO - 'TMOUT': '86400', 03:21:03 INFO - 'USER': 'cltbld', 03:21:03 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:03 INFO - '_': '/tools/buildbot/bin/python'} 03:21:03 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/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 03:21:04 INFO - mozversion application_buildid: 20170906092433 03:21:04 INFO - mozversion application_changeset: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e 03:21:04 INFO - mozversion application_display_name: Nightly 03:21:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:04 INFO - mozversion application_name: Firefox 03:21:04 INFO - mozversion application_remotingname: firefox 03:21:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:21:04 INFO - mozversion application_vendor: Mozilla 03:21:04 INFO - mozversion application_version: 57.0a1 03:21:04 INFO - mozversion platform_buildid: 20170906092433 03:21:04 INFO - mozversion platform_changeset: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e 03:21:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:21:04 INFO - mozversion platform_version: 57.0a1 03:21:04 INFO - using testdate: 1504693264 03:21:04 INFO - actual date: 1504693264 03:21:04 INFO - starting webserver on 'localhost:55911' 03:21:04 INFO - SUITE-START | Running 2 tests 03:21:04 INFO - TEST-START | dromaeo_css 03:21:04 INFO - Initialising browser for dromaeo_css test... 03:21:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55911/getInfo.html -profile /tmp/tmpIRbPN3/profile 03:21:04 INFO - TEST-INFO | started process 7960 (/builds/slave/test/build/application/firefox/firefox http://localhost:55911/getInfo.html) 03:21:09 INFO - TEST-INFO | 7960: exit 0 03:21:09 INFO - Browser initialized. 03:21:09 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:09 INFO - Using env: {'DISPLAY': ':0', 03:21:09 INFO - 'HOME': '/home/cltbld', 03:21:09 INFO - 'JSGC_DISABLE_POISONING': '1', 03:21:09 INFO - 'LANG': 'en_US.UTF-8', 03:21:09 INFO - 'LANGUAGE': 'en_US:en', 03:21:09 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:21:09 INFO - 'LOGNAME': 'cltbld', 03:21:09 INFO - 'MAIL': '/var/mail/cltbld', 03:21:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:09 INFO - 'MOZ_CRASHREPORTER': '1', 03:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:09 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:21:09 INFO - 'MOZ_NO_REMOTE': '1', 03:21:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:09 INFO - 'NO_EM_RESTART': '1', 03:21:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:09 INFO - 'PWD': '/builds/slave/test', 03:21:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:09 INFO - 'RUST_BACKTRACE': 'full', 03:21:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:21:09 INFO - 'SHELL': '/bin/bash', 03:21:09 INFO - 'SHLVL': '1', 03:21:09 INFO - 'STYLO_FORCE_ENABLED': '1', 03:21:09 INFO - 'STYLO_THREADS': '1', 03:21:09 INFO - 'TERM': 'linux', 03:21:09 INFO - 'TMOUT': '86400', 03:21:09 INFO - 'USER': 'cltbld', 03:21:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:09 INFO - '_': '/tools/buildbot/bin/python'} 03:21:09 INFO - TEST-INFO | started process 8146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIRbPN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:10 INFO - PID 8146 | 03:21:10 INFO - PID 8146 | (/builds/slave/test/build/application/firefox/firefox:8199): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:10 INFO - PID 8146 | 03:21:21 INFO - PID 8146 | RSS: Main: 170528768 03:21:21 INFO - PID 8146 | 03:24:18 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:55911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55911/tests/dromaeo/cssquery-ext.html) 03:24:19 INFO - PID 8146 | RSS: Main: 174010368 03:24:19 INFO - PID 8146 | 03:27:21 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:55911/tests/dromaeo/cssquery-ext.html (next: http://localhost:55911/tests/dromaeo/cssquery-jquery.html) 03:27:21 INFO - PID 8146 | RSS: Main: 171589632 03:27:21 INFO - PID 8146 | 03:30:23 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:55911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55911/tests/dromaeo/cssquery-mootools.html) 03:30:24 INFO - PID 8146 | RSS: Main: 173834240 03:30:24 INFO - PID 8146 | 03:33:25 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:55911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55911/tests/dromaeo/cssquery-prototype.html) 03:33:26 INFO - PID 8146 | RSS: Main: 172359680 03:33:26 INFO - PID 8146 | 03:36:29 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:55911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55911/tests/dromaeo/cssquery-yui.html) 03:36:30 INFO - PID 8146 | RSS: Main: 171896832 03:36:30 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | Cycle 1(1): loaded http://localhost:55911/tests/dromaeo/cssquery-yui.html (next: http://localhost:55911/tests/dromaeo/cssquery-dojo.html) 03:39:32 INFO - PID 8146 | RSS: Main: 176312320 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | __start_tp_report 03:39:32 INFO - PID 8146 | _x_x_mozilla_page_load 03:39:32 INFO - PID 8146 | _x_x_mozilla_page_load_details 03:39:32 INFO - PID 8146 | |i|pagename|runs| 03:39:32 INFO - PID 8146 | |0;dojo.html;3223.5003574445955;3263.314703912177;3304.2895777407853;3318.684724951132;3319.883804066858;6389.329120442357;6418.775342863;6431.774887878931;6436.356364363562;6477.967610161949;6278.717457714402;6362.172917520727;6378.681065946707;6387.840303992402;6398.520110991671;5854.5023672987845;5868.706564671749;5869.55978301627;5872.677002764846;5910.645361278337;5899.262592175978;5910.88178236435;5933.19901813254;6008.399160083978;6009.669468179249;5871.765129394819;5942.524598032169;5964.105384192384;5987.131865879445;6039.335673075958;5724.284464441945;5810.1865738796605;5815.680137592431;5923.881522369528;5928.051511758098;5611.3266408031295;5760.308762948431;5815.302163740336;5878.559108066912;5908.527317814564;6321.24145102586;6338.144350512668;6445.097686323918;6456.063870738763;6500.8699826003685;6780.05079288895;6829.3170682931805;6872.793816185523;6877.724891004404;6887.586744795278;6750.493712971547;6948.513604047719;6955.6869940852275;6957.8956315655305;6963.442924566022;6294.118823364733;6318.810435686937;6386.201724784402;6423.775167869149;6450.161479007699;6833.965830170818;6936.791896243019;6949.93050069503;7045.788626341218;7112.893306600405;6758.290379510179;6758.864822703518;6785.1518560179975;6812.080369150201;6816.62508562024;6746.831329216809;6839.452843772487;6917.169939607179;6924.861502769916;6932.6533673316135;6771.4582833373215;6788.932110678928;6809.761658341934;6837.692303846239;6865.27914568973;6841.144856892888;6877.037214789933;6904.965475172692;6910.101686780687;6945.861082778316;4952.331435256267;4962.652614317035;5029.019341228499;5036.949630503721;5040.143175660147;4335.739855608611;4350.912981740411;4356.302991521341;4401.911961760747;4405.185040767468;5876.265466816648;5886.970565147147;5898.085796701518;5898.1152827076285;5916.408359164049;6928.722851086001;6930.410915072174;6942.479314051366;6956.617386043817;6957.095577574883;5956.880862382728;5964.582479226499;5979.431953964367;5980.940190598125;6015.187949626832;5826.592138550261;5833.38749431312;5909.793157239476;5919.911201331984;5937.851553711192;6605.141331626858;6618.404343609098;6687.1975362956755;6702.430293425114;6712.228093769181;6763.086983257295;6871.690773915086;6872.312768723088;6881.449484041164;6882.655867206519;6504.414602685781;6510.153680021567;6531.804045878631;6540.705668245036;6547.803565893031;6683.43190828785;6689.732410703517;6693.330666933268;6693.698783554654;6697.497687673346;6783.4573234142135;6829.726810927706;6831.351021652935;6835.487338449537;6903.0335752995625;6681.064650948968;6683.866322673616;6687.230968438692;6751.02110194029;6758.391744742997;6508.186476690414;6618.338166183343;6627.668616569249;6639.336066393322;6739.898901516383;6500.3174666659315;6524.902126468011;6558.04908288286;6566.6388348641285;6619.139511863427;6586.967065164835;6653.301403352578;6669.599824010575;6683.331666833278;6776.491763117688;6492.577982431316;6492.707828147651;6528.804135875931;6578;6579.703913323816 03:39:32 INFO - PID 8146 | |1;ext.html;796.1799346672925;848.5460278750868;887.7958069643981;890.5191196753754;1223.2110288863678;39404.21191576167;39929.201415971664;40144;40155;40175;38533.614663853354;38604.80697596515;38640.80679596605;38703.41944870829;38723.806380968126;7078.893816592742;7212.603306818123;7214.06217191767;7238.312360325761;7247.239039900787;7143.928560714405;7210.711571537132;7214.42284617232;7217.061781968363;7217.783466496014;7485.700571977114;7576.545407275581;7652.655630496613;7658.731944381948;7681.116671582784;7430.517016393917;7479.7382091626805;7546.2076481969425;7551.848963020709;7557.659905304247;7447.106347238312;7559.622018899033;7561.810954726121;7566.697332106709;7569.848603027964;36164.45753313702;36490.270194596225;36501.63498365009;36564;36587.26825463476;3481.89554313371;3514.033640748789;3515.3848076586496;3541.94687079694;3544.486049522805;30260;30573.38853222945;30692.38615227683;30723.846380768176;30745.846270768725;5212.765425555821;5239.318888544465;5270.077736396115;5277.393099793535;5298.629095963284;194862;195494;195515;196267;197547;46697;46853.297200542016;46882;46944;47002;48451.757741211775;48562.5143748558;48574.514254857706;48801.2679809796;48879.75560122177;14090.365933533016;14315.57053288403;14322.57032289033;14325.713485730226;14335.211563364115;11365.488553015135;11388.772224555629;11395.088392928546;11408;11421.37182454973;12287.447064881922;12559.623211303675;13828.723425531432;13964.022518423815;14169.574912752634;5725;5891.086881533369;5899.823005309848;5909.704514774244;5930.110483427434;991.8908920018793;1025.958961641541;1030.2221822523945;1039.3244391145665;1044.4203467075695;22840.543189136126;22960;23122.65316020261;23245;23481.599904376333;1106.7233191702076;1121.994390028061;1124.3703526025452;1135.5855112883737;1143.5711608146944;12154.392280385946;12379.266902633639;12440.875591244152;12444.128910976146;12452.875471245352;242996;245782;246464;246517;246568;50406.2439063407;50593;50775.746121269156;50874.236886446735;50936.23595646068;1401.3063533550753;1446.1106419552111;1456.919869407193;1457.278647069686;1467.5744034230167;22295.331140065824;22448.775512245324;22459.887700561394;22507.774922250566;22727;36124.27751445009;36318.27363452769;36342;36443.63556364403;36467.45298820573;195719;195825;195944;196058;196797;32030.67969320277;32195.839020804746;32199.51700724444;32228;32247;39726;42931.35602966021;44361.33457998068;44371.556284436745;44376;31392.686073138975;31710.68289317077;31941.36117277595;32034.35931281408;32457;32201.35597288088;32287;32305.676943230268;32860.34279314448;33072.834635826664;36187.45718814167;36276.81861590781;36341.81829090838;36447;36496.45255321226;31159.221019474695;31833.840830795696;31899.68100318967;32057;32131.19672008125;22512.5497490046;24169.033238670258;24378.51242975166;24801.62797558002;25358.590933861255 03:39:32 INFO - PID 8146 | |2;jquery.html;566.2638569859182;567.9886402271952;569.8489900176456;577.7371296060293;587.1691556447627;21775.455613609647;22475.21336753212;22485;22496.66255006174;22498.55002899941;22781;23793.643095353582;24834.254972350813;25055.498890022234;25178;6364.140840986465;6572.244191917919;6583.4074933256;6586.440152587036;6625.337466253361;6154;6368.29948705642;6431.099646049557;6497.772577959772;6498.382653647919;6360.109584658151;6364.140840986453;6371.45842603377;6374.490040796748;6417.486601071926;6371.522135839784;6386.5210109241525;6422.293547709748;6435.195600549955;6445.419912207901;5955.52355811534;5956.463918247378;5973.402659734035;5974.3726908674835;5986.161937328778;28783.985121041536;29072.563911541343;29601.70398296011;29766.70233297661;29786;1997.5805080933021;2039.5614942787372;2044.1312442212;2045.856790024699;2046.8669536480081;19263.51841203967;19271.614567708708;19622.313219037263;19642.80357196424;20191.09140088685;2383.475635360218;2395.652630368587;2433.221369161869;2438.9512209755885;2446.987765061181;139431;143693.28153359165;143825.28087359495;144114;144951;14418.495352662607;14745.999999999785;14926.179060151795;15008.924955375152;15092.54722358331;23161.884190578938;23183;23183.188588399662;23187.188448404224;23232.65151022736;9420.387674801115;9564;9599.47202903833;9723.270754693427;9743.220542356594;8586.699465518677;8594.742157735278;8654.350923680624;8712.651493940299;8968.192862642394;7604.733834315773;8886.333524985652;9111.589978450986;9138.486916098127;9335.859962100574;2562.66908923918;2572.879968861989;2614.7254538273587;2627.934301642474;2669.3860412105323;956.1108169402384;978.2760757039881;990.2820455170088;992.667456402099;1007.8891321954579;19320;19519.8048019518;19648.115834787182;20003.399898003085;23488.412789680395;998.0618218874235;1059.819830628795;1061.0821639281965;1064.9520771565144;1077.2836064017497;10788.730281743019;11007.504662290215;11031.503582338813;11108.944455277671;11177;489569;492097;492799;493014;495245;118958.40520797341;125689;125839;126328.36835815945;126709.36645316714;1214.7509760499076;1223.0887988448662;1262.110212300326;1273.7261488779957;1277.0358379423662;20950.685739714223;21032.05355758964;21095.367138985854;21208.575828483652;21302.254421095186;57905;57911;58806.7059664699;59128.40871591401;61276.38723612707;71492;73482.63258683673;74231.62884185545;74548.62725686554;74562;12081;12506.312152831682;14381.424743010162;14520;15081.472148474752;23195.53608927846;23312.650310245022;23472.53054938926;23526.294211173692;23669.644955326028;17847.732284015492;17930.193141308933;18212.817871821113;18253.178606962985;18478.353257635918;14361.784573231618;15317.770233446285;15425.614359641098;15697.21513924322;16907.66184676275;18113.909430452764;18518.537036574195;18529;18665.906670467102;19024.904875476088;14694.926525367304;14718.705625887209;14752;14776.852231477547;14823.110613363233;18388.08059596988;18403.72394414058;18662.253509859453;18806.6238675223;18820.52948676294 03:39:32 INFO - PID 8146 | |3;mootools.html;1344.2069179184282;1411.55536006158;1418.333383309844;1423.6939058102505;1423.9003269771108;15070.171140587263;15708.764368534481;15713.921430392833;15726.135062571553;15731.370745170194;15847.286872090755;16149.677006459864;16172.433964811235;16179.595510112253;16184.919075404636;2648.311439025848;2767.114523352528;2802.957955630667;2805.3968396794685;2820.873060712273;2825.9576106358422;2850.2589326774983;2859.856057576965;2859.985700071507;2871.052552657618;2751.7523422891936;2763.3367991682053;2768.0865314446182;2773.736495032979;2824.4351129774022;2678.317029157562;2693;2694.2321438389963;2697.64930559028;2706.512827691015;2705.5130076586206;2727.727227277276;2732.2622891819096;2735.302497863052;2755.3111722069484;14901.180435076067;15373.385064597403;15373.615659608487;15401.22993850303;15436.845631543652;7929.405294602928;8249.628766705513;8251.422400431971;8263.793405164859;8268.09051004389;5354.571634269249;5424.077906755861;5496.835094947118;5553.8333849984565;5588.30146231721;1798.784145902487;1807.168702396899;1814.537292990279;1838.6230822681453;1847.436531857783;24366;24548;24671.259862204162;24682;24729.381765455826;7124.750633727795;7126.5746850630085;7318.414526837841;7354.448416368687;7385.335319821242;17098.0596067215;17202.39791607313;17267.222974966156;17278.13609319529;17294.308227671005;7933.920660793434;8071.313938315191;8072.354211663052;8076.3942704297415;8076.596170191467;7438.107427108674;7454.515456495311;7490.400767938552;7508.361789247975;7535.585542795199;5075;5250.372384560798;5251.711155886386;5287.9471205287455;5291.444398338196;1588.2773338131124;1588.6822635472952;1591.6657501924494;1597.1535086404224;1610.8308627594167;870.9259712924472;904.4708845325558;904.4889637354873;914.9222316103072;919.4575200631525;7335.559866408033;7409.481336306515;7413.481056326005;7414.925850741532;7472.551646901204;724.8332883436839;728.2826415980361;729.0413106764588;729.1687476277049;734.4528326396869;5282.7622756976025;5329.333833270841;5439.347278326626;5453.100238460689;5558.416366281563;20825.479363015744;21081.683774743393;21836.89081554614;21926.122955081937;22031.559368812854;21111.050002749915;21436.892815535823;21493.78506214949;21499.247526336814;21565.24521641735;10724.302920310154;11159.330440173615;11451.88548114525;11474.94262528682;11481.885181148082;8177;8828.690995815115;8905.154010369004;9038.367314287936;9088.636454541744;18845.811541884406;19068.237270509024;19222.231110755412;19441;19452.124654390303;18302.542436439195;18443.354482593044;18704.251829926652;19024.42926712201;19951.501212469804;12199.939000304941;12416.130870838955;12444.875551244371;12445.25328480294;12446.377681115728;13852.16886986784;14150.504732334319;14153.150810951376;14170.645733856323;14237.21695306768;11233.775324493628;11294.43527823622;11312.547498100314;11475.540978360772;11578.247413918069;10576.259661823598;10609.575616975235;10634.042936135786;10668.8933110671;10887.292325998786;9891.901080989099;10062.647807326708;10080.798384032132;10082.647107351208;10096.444695541815;7027.789166325018;7049.929500704928;7080.079589653312;7122.964385178041;7190.820229494305;7237.059182306267;7289.1981881994;7331.78004659861;7339.669714862737;7500.699972001059 03:39:32 INFO - PID 8146 | |4;prototype.html;522.1254398881872;524.2843518597114;530.2682298428168;540.2247774443674;544.5589072850988;6283.654399008053;6333.841653958648;6355.71399287032;6371.2991570927215;6380.808575742735;6237.438630523252;6290.1822763040855;6304.936950630492;6311.35904664787;6320.715567799449;5133.152065256514;5185.662931909414;5190.195519694435;5195.532402083812;5232.215167724834;4852.830150944717;4953.380827396575;5130.897382052375;5175.611829112813;5188.42927278001;4914.967856750069;4931.334269873575;4937.444704917957;4965.950340496603;4966.279889416032;4935;4980.9252861207115;4984.576311013569;5018.899622007576;5037.924431133536;4481.305397663367;4515.954840451586;4536.8865778355475;4540.77296135192;4568.406107206075;6111.694415279218;6161.537884658668;6187.690615469209;6213.347598502138;6237.750489980395;5603.831885043455;5648.943510564883;5659.971700141514;5701.6864072476;5733.226014488033;6452.64510451925;6524.967375163142;6528.869422611569;6537.280899101095;6583.6708164592055;4871.975640121812;4881.1213981483315;4881.243407271879;4883.291922671228;4905.901881962341;6675.664867026566;6734.629595372204;6794.864102717967;6831.555948863308;6876.828079298008;4859.514048595183;5008.824691135793;5013.799448022111;5033.395992480852;5055.660250033744;5049.2426136079885;5082.110630639623;5089.9745501272255;5117.641765076483;5131.666441681279;5612.298462692163;5674.319081710221;5680.261565996394;5683.374828768832;5710.172025056427;6560.572588142418;6588.308227636125;6638.336166383323;6658.801415745115;6661.666916654245;1758.78015248094;1777.7688900442859;1779.5373202967062;1779.9822001779817;1789.3111152206234;1154.3766366162347;1228.3980849383738;1235.4996226528272;1238.5293588436516;1253.354522420954;5664.801731939362;5720.570957178145;5771.624844385102;5782.190493330937;5799.971000145057;6662.800115996528;6702.692974869854;6713.362230588086;6790.660466976631;6821.2155602106395;5651.745671444713;5707.771689132472;5719.7712091516705;5740.827775166752;5799.420057994251;3499.562554680665;3540.8047010853434;3546.3261980223674;3565.3760591896316;3590.8025058621506;6458.838529036811;6477.57895736785;6512.023196520559;6520.315366886409;6577;6364.459020983176;6780.660966951633;6907.861842763116;6915.930840691629;6974.616396098162;6333.271673757485;6428.5178611604315;6436.227652681615;6456.515761317826;6477.870442591122;6597.736090556324;6608.867822643617;6703.262641109376;6714.294999025032;6729.865402691821;6607.438367738796;6623.801285961429;6628.403443690091;6638.767643132467;6663.400293973566;6343.904841427475;6346.936530634634;6396.93603063982;6401.879671057453;6421.325760795236;4971.577415919687;4991.875203119951;4993.80024799004;5006.799728010838;5054.898902022012;6475.222973243052;6543.247526534509;6638.5684930479365;6662.234507855325;6797.93202067973;6411.8717625646295;6422.743090276524;6500.967495162494;6525.608463492205;6537.378948999837;6400.359964003563;6401.55189136756;6411.326810684811;6418.010416770816;6471.870562588816;6359.332270111571;6363.172787537776;6419.518536109717;6452.096706461193;6486.124373209556;6526.24948130971;6540.574862633914;6545.770898018546;6563;6563.507736919654;6292.2134733158355;6341.682915854281;6366.9681651591445;6382.5532212744665;6386.371475273962 03:39:32 INFO - PID 8146 | |5;yui.html;889.8398288308106;903.8192361527693;919.7286800393883;927.5176908007836;930.8696782450459;18037.819621803796;18661.16024778885;18674.439766806983;18685.813141868577;18707.71938420925;17572.472825815214;18689.065546722642;21832.345029649096;21968;22012.779872201274;987.2299606307092;1001.7445551384387;1005.7234260578363;1008.1380419741125;1008.8083264179819;890.0787684746289;981.175812317653;998.7003898830358;1001.1690297053465;1002.6190047781869;1032.7986042721673;1051.621416290135;1051.7633532455175;1052.0216198934988;1052.5316234275751;1031.2317323593895;1044.926855120142;1048.7849990751877;1049.2655141401049;1049.4123290957011;758.1395116542764;768.8193274580469;770.2605498721234;772.3010675338827;773.9729109481198;19842.900785495982;19857.50356241091;20184.19263229469;20245.595088098304;20354.79645203544;20958.371248862557;21037.263695770576;21477.67783483249;21512.031958561904;21609;15265.542033739006;15849.207539622972;15891;15899.046057236603;15913.283902224428;3760.0411894966883;3760.2855457462992;3790.0903783092135;3800.5819359870393;3801.6768574671187;125962;128611;128650.3567482166;130287;133312;16193.109378984032;16366.918165409335;16395.098269595048;16563.08903010346;16622.667546648998;29826.403471930873;30221.395572088437;30456;30485.39029219403;30565.541516877263;8617.095205003385;8648.913510864937;8666.436681615802;8685.869711954325;8692.913070869337;4132.40080188377;4202.831886724497;4208.074223670787;4267;4412.051408947092;5235.4502777207845;5333.359996800331;5349.652272602269;5350.197470379474;5372.516473517402;1023.2121266624657;1079.6059438304962;1123.8876112388696;1134.7276653603242;1134.9319040857574;697.424624684627;709.6061685764347;714.6926821466819;721.5057685485459;736.6537727268176;12114.8490893365;12159.392030398445;12226.938865305616;12526;12539.811902821464;672.9024291477708;684.9280825513349;695.6799872058808;706.9151701795714;711.79713781572;5875.41245875409;5885.499732522783;5890.941090589039;5925.933332000195;6007.128966299862;106228;108932.4553377228;113281;114144.42927785308;124934;95005;101098;105299;110910;111697;89200.5539972296;93694;96194;100049.49975250223;102660;11791.741185168958;13239.073264871367;13340.866591333963;13431.462741490232;13477.797833032317;42308.57691423169;42750.78624606857;42762.57237427586;42972;43829.12341753211;71991.28008719845;72797.27202727905;73162;73283;73654.63172684102;18008.909955450137;18869.43391698251;18884.905575472585;18907.243710251434;18917.054147292856;20286.695699564225;20753.06611202469;21262.893685532094;21417.89291053535;21801.781982179975;19317.4204773857;19607.509812254808;19614.215431382585;20019.899900500986;20175.79824201739;18757.531061723566;18829;19162.7125593119;19303.131359088595;19544;16926.492205233862;17059.829401705825;17226.913865430593;18915.337963171223;19360.61278774445;12901.935490322488;13967.580972570839;14255.572332830032;14263.64340891486;14931.029483083565;14239.572812815217;14684.85315146835;14784.48254311094;14839.629009274855;15396.230188490754 03:39:32 INFO - PID 8146 | __end_tp_report 03:39:32 INFO - PID 8146 | __start_cc_report 03:39:32 INFO - PID 8146 | _x_x_mozilla_cycle_collect,371 03:39:32 INFO - PID 8146 | __end_cc_report 03:39:32 INFO - PID 8146 | __startTimestamp1504694372349__endTimestamp 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | ------- Summary: start ------- 03:39:32 INFO - PID 8146 | Number of tests: 6 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | [#0] dojo.html Cycles:165 Average:6277.30 Median:6528.80 stddev:783.22 (12.0%) stddev-sans-first:748.09 03:39:32 INFO - PID 8146 | Values: 3223.5 3263.3 3304.3 3318.7 3319.9 6389.3 6418.8 6431.8 6436.4 6478.0 6278.7 6362.2 6378.7 6387.8 6398.5 5854.5 5868.7 5869.6 5872.7 5910.6 5899.3 5910.9 5933.2 6008.4 6009.7 5871.8 5942.5 5964.1 5987.1 6039.3 5724.3 5810.2 5815.7 5923.9 5928.1 5611.3 5760.3 5815.3 5878.6 5908.5 6321.2 6338.1 6445.1 6456.1 6500.9 6780.1 6829.3 6872.8 6877.7 6887.6 6750.5 6948.5 6955.7 6957.9 6963.4 6294.1 6318.8 6386.2 6423.8 6450.2 6834.0 6936.8 6949.9 7045.8 7112.9 6758.3 6758.9 6785.2 6812.1 6816.6 6746.8 6839.5 6917.2 6924.9 6932.7 6771.5 6788.9 6809.8 6837.7 6865.3 6841.1 6877.0 6905.0 6910.1 6945.9 4952.3 4962.7 5029.0 5036.9 5040.1 4335.7 4350.9 4356.3 4401.9 4405.2 5876.3 5887.0 5898.1 5898.1 5916.4 6928.7 6930.4 6942.5 6956.6 6957.1 5956.9 5964.6 5979.4 5980.9 6015.2 5826.6 5833.4 5909.8 5919.9 5937.9 6605.1 6618.4 6687.2 6702.4 6712.2 6763.1 6871.7 6872.3 6881.4 6882.7 6504.4 6510.2 6531.8 6540.7 6547.8 6683.4 6689.7 6693.3 6693.7 6697.5 6783.5 6829.7 6831.4 6835.5 6903.0 6681.1 6683.9 6687.2 6751.0 6758.4 6508.2 6618.3 6627.7 6639.3 6739.9 6500.3 6524.9 6558.0 6566.6 6619.1 6587.0 6653.3 6669.6 6683.3 6776.5 6492.6 6492.7 6528.8 6578.0 6579.7 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | [#1] ext.html Cycles:180 Average:37538.51 Median:3497.96 stddev:55490.53 (1586.4%) stddev-sans-first:55577.62 03:39:32 INFO - PID 8146 | Values: 796.2 848.5 887.8 890.5 1223.2 39404.2 39929.2 40144.0 40155.0 40175.0 38533.6 38604.8 38640.8 38703.4 38723.8 7078.9 7212.6 7214.1 7238.3 7247.2 7143.9 7210.7 7214.4 7217.1 7217.8 7485.7 7576.5 7652.7 7658.7 7681.1 7430.5 7479.7 7546.2 7551.8 7557.7 7447.1 7559.6 7561.8 7566.7 7569.8 36164.5 36490.3 36501.6 36564.0 36587.3 3481.9 3514.0 3515.4 3541.9 3544.5 30260.0 30573.4 30692.4 30723.8 30745.8 5212.8 5239.3 5270.1 5277.4 5298.6 194862.0 195494.0 195515.0 196267.0 197547.0 46697.0 46853.3 46882.0 46944.0 47002.0 48451.8 48562.5 48574.5 48801.3 48879.8 14090.4 14315.6 14322.6 14325.7 14335.2 11365.5 11388.8 11395.1 11408.0 11421.4 12287.4 12559.6 13828.7 13964.0 14169.6 5725.0 5891.1 5899.8 5909.7 5930.1 991.9 1026.0 1030.2 1039.3 1044.4 22840.5 22960.0 23122.7 23245.0 23481.6 1106.7 1122.0 1124.4 1135.6 1143.6 12154.4 12379.3 12440.9 12444.1 12452.9 242996.0 245782.0 246464.0 246517.0 246568.0 50406.2 50593.0 50775.7 50874.2 50936.2 1401.3 1446.1 1456.9 1457.3 1467.6 22295.3 22448.8 22459.9 22507.8 22727.0 36124.3 36318.3 36342.0 36443.6 36467.5 195719.0 195825.0 195944.0 196058.0 196797.0 32030.7 32195.8 32199.5 32228.0 32247.0 39726.0 42931.4 44361.3 44371.6 44376.0 31392.7 31710.7 31941.4 32034.4 32457.0 32201.4 32287.0 32305.7 32860.3 33072.8 36187.5 36276.8 36341.8 36447.0 36496.5 31159.2 31833.8 31899.7 32057.0 32131.2 22512.5 24169.0 24378.5 24801.6 25358.6 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | [#2] jquery.html Cycles:180 Average:35330.16 Median:23272.65 stddev:83469.06 (358.7%) stddev-sans-first:83662.40 03:39:32 INFO - PID 8146 | Values: 566.3 568.0 569.8 577.7 587.2 21775.5 22475.2 22485.0 22496.7 22498.6 22781.0 23793.6 24834.3 25055.5 25178.0 6364.1 6572.2 6583.4 6586.4 6625.3 6154.0 6368.3 6431.1 6497.8 6498.4 6360.1 6364.1 6371.5 6374.5 6417.5 6371.5 6386.5 6422.3 6435.2 6445.4 5955.5 5956.5 5973.4 5974.4 5986.2 28784.0 29072.6 29601.7 29766.7 29786.0 1997.6 2039.6 2044.1 2045.9 2046.9 19263.5 19271.6 19622.3 19642.8 20191.1 2383.5 2395.7 2433.2 2439.0 2447.0 139431.0 143693.3 143825.3 144114.0 144951.0 14418.5 14746.0 14926.2 15008.9 15092.5 23161.9 23183.0 23183.2 23187.2 23232.7 9420.4 9564.0 9599.5 9723.3 9743.2 8586.7 8594.7 8654.4 8712.7 8968.2 7604.7 8886.3 9111.6 9138.5 9335.9 2562.7 2572.9 2614.7 2627.9 2669.4 956.1 978.3 990.3 992.7 1007.9 19320.0 19519.8 19648.1 20003.4 23488.4 998.1 1059.8 1061.1 1065.0 1077.3 10788.7 11007.5 11031.5 11108.9 11177.0 489569.0 492097.0 492799.0 493014.0 495245.0 118958.4 125689.0 125839.0 126328.4 126709.4 1214.8 1223.1 1262.1 1273.7 1277.0 20950.7 21032.1 21095.4 21208.6 21302.3 57905.0 57911.0 58806.7 59128.4 61276.4 71492.0 73482.6 74231.6 74548.6 74562.0 12081.0 12506.3 14381.4 14520.0 15081.5 23195.5 23312.7 23472.5 23526.3 23669.6 17847.7 17930.2 18212.8 18253.2 18478.4 14361.8 15317.8 15425.6 15697.2 16907.7 18113.9 18518.5 18529.0 18665.9 19024.9 14694.9 14718.7 14752.0 14776.9 14823.1 18388.1 18403.7 18662.3 18806.6 18820.5 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | [#3] mootools.html Cycles:180 Average:9382.60 Median:2685.66 stddev:6588.30 (245.3%) stddev-sans-first:6579.09 03:39:32 INFO - PID 8146 | Values: 1344.2 1411.6 1418.3 1423.7 1423.9 15070.2 15708.8 15713.9 15726.1 15731.4 15847.3 16149.7 16172.4 16179.6 16184.9 2648.3 2767.1 2803.0 2805.4 2820.9 2826.0 2850.3 2859.9 2860.0 2871.1 2751.8 2763.3 2768.1 2773.7 2824.4 2678.3 2693.0 2694.2 2697.6 2706.5 2705.5 2727.7 2732.3 2735.3 2755.3 14901.2 15373.4 15373.6 15401.2 15436.8 7929.4 8249.6 8251.4 8263.8 8268.1 5354.6 5424.1 5496.8 5553.8 5588.3 1798.8 1807.2 1814.5 1838.6 1847.4 24366.0 24548.0 24671.3 24682.0 24729.4 7124.8 7126.6 7318.4 7354.4 7385.3 17098.1 17202.4 17267.2 17278.1 17294.3 7933.9 8071.3 8072.4 8076.4 8076.6 7438.1 7454.5 7490.4 7508.4 7535.6 5075.0 5250.4 5251.7 5287.9 5291.4 1588.3 1588.7 1591.7 1597.2 1610.8 870.9 904.5 904.5 914.9 919.5 7335.6 7409.5 7413.5 7414.9 7472.6 724.8 728.3 729.0 729.2 734.5 5282.8 5329.3 5439.3 5453.1 5558.4 20825.5 21081.7 21836.9 21926.1 22031.6 21111.1 21436.9 21493.8 21499.2 21565.2 10724.3 11159.3 11451.9 11474.9 11481.9 8177.0 8828.7 8905.2 9038.4 9088.6 18845.8 19068.2 19222.2 19441.0 19452.1 18302.5 18443.4 18704.3 19024.4 19951.5 12199.9 12416.1 12444.9 12445.3 12446.4 13852.2 14150.5 14153.2 14170.6 14237.2 11233.8 11294.4 11312.5 11475.5 11578.2 10576.3 10609.6 10634.0 10668.9 10887.3 9891.9 10062.6 10080.8 10082.6 10096.4 7027.8 7049.9 7080.1 7123.0 7190.8 7237.1 7289.2 7331.8 7339.7 7500.7 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | [#4] prototype.html Cycles:180 Average:5508.91 Median:6260.70 stddev:1529.91 (24.4%) stddev-sans-first:1487.72 03:39:32 INFO - PID 8146 | Values: 522.1 524.3 530.3 540.2 544.6 6283.7 6333.8 6355.7 6371.3 6380.8 6237.4 6290.2 6304.9 6311.4 6320.7 5133.2 5185.7 5190.2 5195.5 5232.2 4852.8 4953.4 5130.9 5175.6 5188.4 4915.0 4931.3 4937.4 4966.0 4966.3 4935.0 4980.9 4984.6 5018.9 5037.9 4481.3 4516.0 4536.9 4540.8 4568.4 6111.7 6161.5 6187.7 6213.3 6237.8 5603.8 5648.9 5660.0 5701.7 5733.2 6452.6 6525.0 6528.9 6537.3 6583.7 4872.0 4881.1 4881.2 4883.3 4905.9 6675.7 6734.6 6794.9 6831.6 6876.8 4859.5 5008.8 5013.8 5033.4 5055.7 5049.2 5082.1 5090.0 5117.6 5131.7 5612.3 5674.3 5680.3 5683.4 5710.2 6560.6 6588.3 6638.3 6658.8 6661.7 1758.8 1777.8 1779.5 1780.0 1789.3 1154.4 1228.4 1235.5 1238.5 1253.4 5664.8 5720.6 5771.6 5782.2 5800.0 6662.8 6702.7 6713.4 6790.7 6821.2 5651.7 5707.8 5719.8 5740.8 5799.4 3499.6 3540.8 3546.3 3565.4 3590.8 6458.8 6477.6 6512.0 6520.3 6577.0 6364.5 6780.7 6907.9 6915.9 6974.6 6333.3 6428.5 6436.2 6456.5 6477.9 6597.7 6608.9 6703.3 6714.3 6729.9 6607.4 6623.8 6628.4 6638.8 6663.4 6343.9 6346.9 6396.9 6401.9 6421.3 4971.6 4991.9 4993.8 5006.8 5054.9 6475.2 6543.2 6638.6 6662.2 6797.9 6411.9 6422.7 6501.0 6525.6 6537.4 6400.4 6401.6 6411.3 6418.0 6471.9 6359.3 6363.2 6419.5 6452.1 6486.1 6526.2 6540.6 6545.8 6563.0 6563.5 6292.2 6341.7 6367.0 6382.6 6386.4 03:39:32 INFO - PID 8146 | 03:39:32 INFO - PID 8146 | [#5] yui.html Cycles:180 Average:24717.35 Median:19610.86 stddev:33850.46 (172.6%) stddev-sans-first:33898.13 03:39:32 INFO - PID 8146 | Values: 889.8 903.8 919.7 927.5 930.9 18037.8 18661.2 18674.4 18685.8 18707.7 17572.5 18689.1 21832.3 21968.0 22012.8 987.2 1001.7 1005.7 1008.1 1008.8 890.1 981.2 998.7 1001.2 1002.6 1032.8 1051.6 1051.8 1052.0 1052.5 1031.2 1044.9 1048.8 1049.3 1049.4 758.1 768.8 770.3 772.3 774.0 19842.9 19857.5 20184.2 20245.6 20354.8 20958.4 21037.3 21477.7 21512.0 21609.0 15265.5 15849.2 15891.0 15899.0 15913.3 3760.0 3760.3 3790.1 3800.6 3801.7 125962.0 128611.0 128650.4 130287.0 133312.0 16193.1 16366.9 16395.1 16563.1 16622.7 29826.4 30221.4 30456.0 30485.4 30565.5 8617.1 8648.9 8666.4 8685.9 8692.9 4132.4 4202.8 4208.1 4267.0 4412.1 5235.5 5333.4 5349.7 5350.2 5372.5 1023.2 1079.6 1123.9 1134.7 1134.9 697.4 709.6 714.7 721.5 736.7 12114.8 12159.4 12226.9 12526.0 12539.8 672.9 684.9 695.7 706.9 711.8 5875.4 5885.5 5890.9 5925.9 6007.1 106228.0 108932.5 113281.0 114144.4 124934.0 95005.0 101098.0 105299.0 110910.0 111697.0 89200.6 93694.0 96194.0 100049.5 102660.0 11791.7 13239.1 13340.9 13431.5 13477.8 42308.6 42750.8 42762.6 42972.0 43829.1 71991.3 72797.3 73162.0 73283.0 73654.6 18008.9 18869.4 18884.9 18907.2 18917.1 20286.7 20753.1 21262.9 21417.9 21801.8 19317.4 19607.5 19614.2 20019.9 20175.8 18757.5 18829.0 19162.7 19303.1 19544.0 16926.5 17059.8 17226.9 18915.3 19360.6 12901.9 13967.6 14255.6 14263.6 14931.0 14239.6 14684.9 14784.5 14839.6 15396.2 03:39:32 INFO - PID 8146 | -------- Summary: end -------- 03:39:32 INFO - PID 8146 | 03:39:33 INFO - TEST-INFO | 8146: exit 0 03:39:33 INFO - TEST-OK | dromaeo_css | took 1108825ms 03:39:33 INFO - TEST-START | kraken 03:39:33 INFO - Initialising browser for kraken test... 03:39:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55911/getInfo.html -profile /tmp/tmph7Q1Id/profile 03:39:33 INFO - TEST-INFO | started process 8520 (/builds/slave/test/build/application/firefox/firefox http://localhost:55911/getInfo.html) 03:39:37 INFO - TEST-INFO | 8520: exit 0 03:39:38 INFO - Browser initialized. 03:39:38 INFO - Running cycle 1/1 for kraken test... 03:39:38 INFO - Using env: {'DISPLAY': ':0', 03:39:38 INFO - 'HOME': '/home/cltbld', 03:39:38 INFO - 'JSGC_DISABLE_POISONING': '1', 03:39:38 INFO - 'LANG': 'en_US.UTF-8', 03:39:38 INFO - 'LANGUAGE': 'en_US:en', 03:39:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:39:38 INFO - 'LOGNAME': 'cltbld', 03:39:38 INFO - 'MAIL': '/var/mail/cltbld', 03:39:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:39:38 INFO - 'MOZ_CRASHREPORTER': '1', 03:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:39:38 INFO - 'MOZ_NO_REMOTE': '1', 03:39:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:38 INFO - 'NO_EM_RESTART': '1', 03:39:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:38 INFO - 'PWD': '/builds/slave/test', 03:39:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:38 INFO - 'RUST_BACKTRACE': 'full', 03:39:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:39:38 INFO - 'SHELL': '/bin/bash', 03:39:38 INFO - 'SHLVL': '1', 03:39:38 INFO - 'STYLO_FORCE_ENABLED': '1', 03:39:38 INFO - 'STYLO_THREADS': '1', 03:39:38 INFO - 'TERM': 'linux', 03:39:38 INFO - 'TMOUT': '86400', 03:39:38 INFO - 'USER': 'cltbld', 03:39:38 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501', 03:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:38 INFO - '_': '/tools/buildbot/bin/python'} 03:39:38 INFO - TEST-INFO | started process 8707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph7Q1Id/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:39 INFO - PID 8707 | 03:39:39 INFO - PID 8707 | (/builds/slave/test/build/application/firefox/firefox:8760): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:39:39 INFO - PID 8707 | 03:39:49 INFO - PID 8707 | RSS: Main: 171982848 03:39:49 INFO - PID 8707 | 03:39:51 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55911/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:52 INFO - PID 8707 | RSS: Main: 178130944 03:39:52 INFO - PID 8707 | 03:39:55 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55911/tests/kraken/driver.html?testName=audio-dft) 03:39:56 INFO - PID 8707 | RSS: Main: 178253824 03:39:56 INFO - PID 8707 | 03:39:59 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55911/tests/kraken/driver.html?testName=audio-fft) 03:39:59 INFO - PID 8707 | RSS: Main: 173006848 03:39:59 INFO - PID 8707 | 03:40:01 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55911/tests/kraken/driver.html?testName=audio-oscillator) 03:40:02 INFO - PID 8707 | RSS: Main: 173367296 03:40:02 INFO - PID 8707 | 03:40:04 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:40:05 INFO - PID 8707 | RSS: Main: 173916160 03:40:05 INFO - PID 8707 | 03:40:08 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55911/tests/kraken/driver.html?testName=imaging-darkroom) 03:40:09 INFO - PID 8707 | RSS: Main: 176226304 03:40:09 INFO - PID 8707 | 03:40:12 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55911/tests/kraken/driver.html?testName=imaging-desaturate) 03:40:13 INFO - PID 8707 | RSS: Main: 177229824 03:40:13 INFO - PID 8707 | 03:40:16 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55911/tests/kraken/driver.html?testName=json-parse-financial) 03:40:16 INFO - PID 8707 | RSS: Main: 177111040 03:40:16 INFO - PID 8707 | 03:40:18 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:40:19 INFO - PID 8707 | RSS: Main: 177373184 03:40:19 INFO - PID 8707 | 03:40:20 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:40:21 INFO - PID 8707 | RSS: Main: 177217536 03:40:21 INFO - PID 8707 | 03:40:23 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:40:23 INFO - PID 8707 | RSS: Main: 174223360 03:40:23 INFO - PID 8707 | 03:40:26 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:27 INFO - PID 8707 | RSS: Main: 174841856 03:40:27 INFO - PID 8707 | 03:40:30 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:30 INFO - PID 8707 | RSS: Main: 174714880 03:40:30 INFO - PID 8707 | 03:40:32 INFO - PID 8707 | Cycle 1(1): loaded http://localhost:55911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55911/tests/kraken/driver.html?testName=ai-astar) 03:40:33 INFO - PID 8707 | RSS: Main: 176275456 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | __start_tp_report 03:40:33 INFO - PID 8707 | _x_x_mozilla_page_load 03:40:33 INFO - PID 8707 | _x_x_mozilla_page_load_details 03:40:33 INFO - PID 8707 | |i|pagename|runs| 03:40:33 INFO - PID 8707 | |0;ai-astar;99;108;99;108;106;110;108;99;106;109 03:40:33 INFO - PID 8707 | |1;audio-beat-detection;148;117;152;191;122;153;145;120;174;119 03:40:33 INFO - PID 8707 | |2;audio-dft;161;162;167;163;162;161;166;171;164;162 03:40:33 INFO - PID 8707 | |3;audio-fft;73;74;74;172;75;75;74;74;162;75 03:40:33 INFO - PID 8707 | |4;audio-oscillator;79;79;128;79;80;79;129;82;79;133 03:40:33 INFO - PID 8707 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;118;114;113 03:40:33 INFO - PID 8707 | |6;imaging-darkroom;148;149;148;149;148;148;149;148;148;148 03:40:33 INFO - PID 8707 | |7;imaging-desaturate;95;93;94;96;95;94;94;95;93;93 03:40:33 INFO - PID 8707 | |8;json-parse-financial;57;54;56;54;53;53;53;58;53;55 03:40:33 INFO - PID 8707 | |9;json-stringify-tinderbox;37;38;37;38;37;37;39;38;38;38 03:40:33 INFO - PID 8707 | |10;stanford-crypto-aes;76;75;75;76;74;75;75;76;77;74 03:40:33 INFO - PID 8707 | |11;stanford-crypto-ccm;115;125;127;116;123;121;117;117;116;165 03:40:33 INFO - PID 8707 | |12;stanford-crypto-pbkdf2;174;176;171;180;183;172;176;170;175;170 03:40:33 INFO - PID 8707 | |13;stanford-crypto-sha256-iterative;69;65;65;65;66;66;65;66;69;64 03:40:33 INFO - PID 8707 | __end_tp_report 03:40:33 INFO - PID 8707 | __start_cc_report 03:40:33 INFO - PID 8707 | _x_x_mozilla_cycle_collect,943 03:40:33 INFO - PID 8707 | __end_cc_report 03:40:33 INFO - PID 8707 | __startTimestamp1504694433002__endTimestamp 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | ------- Summary: start ------- 03:40:33 INFO - PID 8707 | Number of tests: 14 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#0] ai-astar Cycles:10 Average:105.20 Median:109.50 stddev:4.44 (4.1%) stddev-sans-first:4.11 03:40:33 INFO - PID 8707 | Values: 99.0 108.0 99.0 108.0 106.0 110.0 108.0 99.0 106.0 109.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:150.00 stddev:25.13 (16.8%) stddev-sans-first:26.62 03:40:33 INFO - PID 8707 | Values: 148.0 117.0 152.0 191.0 122.0 153.0 145.0 120.0 174.0 119.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.21 (2.0%) stddev-sans-first:3.23 03:40:33 INFO - PID 8707 | Values: 161.0 162.0 167.0 163.0 162.0 161.0 166.0 171.0 164.0 162.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.00 stddev:39.18 (52.9%) stddev-sans-first:40.90 03:40:33 INFO - PID 8707 | Values: 73.0 74.0 74.0 172.0 75.0 75.0 74.0 74.0 162.0 75.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:24.41 (30.9%) stddev-sans-first:25.22 03:40:33 INFO - PID 8707 | Values: 79.0 79.0 128.0 79.0 80.0 79.0 129.0 82.0 79.0 133.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.34 (1.2%) stddev-sans-first:1.41 03:40:33 INFO - PID 8707 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 118.0 114.0 113.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:40:33 INFO - PID 8707 | Values: 148.0 149.0 148.0 149.0 148.0 148.0 149.0 148.0 148.0 148.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.50 stddev:1.03 (1.1%) stddev-sans-first:1.05 03:40:33 INFO - PID 8707 | Values: 95.0 93.0 94.0 96.0 95.0 94.0 94.0 95.0 93.0 93.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.84 (3.4%) stddev-sans-first:1.73 03:40:33 INFO - PID 8707 | Values: 57.0 54.0 56.0 54.0 53.0 53.0 53.0 58.0 53.0 55.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.67 03:40:33 INFO - PID 8707 | Values: 37.0 38.0 37.0 38.0 37.0 37.0 39.0 38.0 38.0 38.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 03:40:33 INFO - PID 8707 | Values: 76.0 75.0 75.0 76.0 74.0 75.0 75.0 76.0 77.0 74.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:122.00 stddev:14.94 (12.2%) stddev-sans-first:15.47 03:40:33 INFO - PID 8707 | Values: 115.0 125.0 127.0 116.0 123.0 121.0 117.0 117.0 116.0 165.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.50 stddev:4.30 (2.4%) stddev-sans-first:4.55 03:40:33 INFO - PID 8707 | Values: 174.0 176.0 171.0 180.0 183.0 172.0 176.0 170.0 175.0 170.0 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.41 03:40:33 INFO - PID 8707 | Values: 69.0 65.0 65.0 65.0 66.0 66.0 65.0 66.0 69.0 64.0 03:40:33 INFO - PID 8707 | -------- Summary: end -------- 03:40:33 INFO - PID 8707 | 03:40:33 INFO - PID 8707 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:40:33 INFO - TEST-INFO | 8707: exit 0 03:40:33 INFO - TEST-OK | kraken | took 60703ms 03:40:33 INFO - SUITE-END | took 1169s 03:40:34 INFO - Completed test suite (00:19:29) 03:40:34 INFO - javascript benchmark 03:40:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8578.695297785254, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3223.5003574445955, 3263.314703912177, 3304.2895777407853, 3318.684724951132, 3319.883804066858, 6389.329120442357, 6418.775342863, 6431.774887878931, 6436.356364363562, 6477.967610161949, 6278.717457714402, 6362.172917520727, 6378.681065946707, 6387.840303992402, 6398.520110991671, 5854.5023672987845, 5868.706564671749, 5869.55978301627, 5872.677002764846, 5910.645361278337, 5899.262592175978, 5910.88178236435, 5933.19901813254, 6008.399160083978, 6009.669468179249, 5871.765129394819, 5942.524598032169, 5964.105384192384, 5987.131865879445, 6039.335673075958, 5724.284464441945, 5810.1865738796605, 5815.680137592431, 5923.881522369528, 5928.051511758098, 5611.3266408031295, 5760.308762948431, 5815.302163740336, 5878.559108066912, 5908.527317814564, 6321.24145102586, 6338.144350512668, 6445.097686323918, 6456.063870738763, 6500.8699826003685, 6780.05079288895, 6829.3170682931805, 6872.793816185523, 6877.724891004404, 6887.586744795278, 6750.493712971547, 6948.513604047719, 6955.6869940852275, 6957.8956315655305, 6963.442924566022, 6294.118823364733, 6318.810435686937, 6386.201724784402, 6423.775167869149, 6450.161479007699, 6833.965830170818, 6936.791896243019, 6949.93050069503, 7045.788626341218, 7112.893306600405, 6758.290379510179, 6758.864822703518, 6785.1518560179975, 6812.080369150201, 6816.62508562024, 6746.831329216809, 6839.452843772487, 6917.169939607179, 6924.861502769916, 6932.6533673316135, 6771.4582833373215, 6788.932110678928, 6809.761658341934, 6837.692303846239, 6865.27914568973, 6841.144856892888, 6877.037214789933, 6904.965475172692, 6910.101686780687, 6945.861082778316, 4952.331435256267, 4962.652614317035, 5029.019341228499, 5036.949630503721, 5040.143175660147, 4335.739855608611, 4350.912981740411, 4356.302991521341, 4401.911961760747, 4405.185040767468, 5876.265466816648, 5886.970565147147, 5898.085796701518, 5898.1152827076285, 5916.408359164049, 6928.722851086001, 6930.410915072174, 6942.479314051366, 6956.617386043817, 6957.095577574883, 5956.880862382728, 5964.582479226499, 5979.431953964367, 5980.940190598125, 6015.187949626832, 5826.592138550261, 5833.38749431312, 5909.793157239476, 5919.911201331984, 5937.851553711192, 6605.141331626858, 6618.404343609098, 6687.1975362956755, 6702.430293425114, 6712.228093769181, 6763.086983257295, 6871.690773915086, 6872.312768723088, 6881.449484041164, 6882.655867206519, 6504.414602685781, 6510.153680021567, 6531.804045878631, 6540.705668245036, 6547.803565893031, 6683.43190828785, 6689.732410703517, 6693.330666933268, 6693.698783554654, 6697.497687673346, 6783.4573234142135, 6829.726810927706, 6831.351021652935, 6835.487338449537, 6903.0335752995625, 6681.064650948968, 6683.866322673616, 6687.230968438692, 6751.02110194029, 6758.391744742997, 6508.186476690414, 6618.338166183343, 6627.668616569249, 6639.336066393322, 6739.898901516383, 6500.3174666659315, 6524.902126468011, 6558.04908288286, 6566.6388348641285, 6619.139511863427, 6586.967065164835, 6653.301403352578, 6669.599824010575, 6683.331666833278, 6776.491763117688, 6492.577982431316, 6492.707828147651, 6528.804135875931, 6578.0, 6579.703913323816], "value": 6215.920750025421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.1799346672925, 848.5460278750868, 887.7958069643981, 890.5191196753754, 1223.2110288863678, 39404.21191576167, 39929.201415971664, 40144.0, 40155.0, 40175.0, 38533.614663853354, 38604.80697596515, 38640.80679596605, 38703.41944870829, 38723.806380968126, 7078.893816592742, 7212.603306818123, 7214.06217191767, 7238.312360325761, 7247.239039900787, 7143.928560714405, 7210.711571537132, 7214.42284617232, 7217.061781968363, 7217.783466496014, 7485.700571977114, 7576.545407275581, 7652.655630496613, 7658.731944381948, 7681.116671582784, 7430.517016393917, 7479.7382091626805, 7546.2076481969425, 7551.848963020709, 7557.659905304247, 7447.106347238312, 7559.622018899033, 7561.810954726121, 7566.697332106709, 7569.848603027964, 36164.45753313702, 36490.270194596225, 36501.63498365009, 36564.0, 36587.26825463476, 3481.89554313371, 3514.033640748789, 3515.3848076586496, 3541.94687079694, 3544.486049522805, 30260.0, 30573.38853222945, 30692.38615227683, 30723.846380768176, 30745.846270768725, 5212.765425555821, 5239.318888544465, 5270.077736396115, 5277.393099793535, 5298.629095963284, 194862.0, 195494.0, 195515.0, 196267.0, 197547.0, 46697.0, 46853.297200542016, 46882.0, 46944.0, 47002.0, 48451.757741211775, 48562.5143748558, 48574.514254857706, 48801.2679809796, 48879.75560122177, 14090.365933533016, 14315.57053288403, 14322.57032289033, 14325.713485730226, 14335.211563364115, 11365.488553015135, 11388.772224555629, 11395.088392928546, 11408.0, 11421.37182454973, 12287.447064881922, 12559.623211303675, 13828.723425531432, 13964.022518423815, 14169.574912752634, 5725.0, 5891.086881533369, 5899.823005309848, 5909.704514774244, 5930.110483427434, 991.8908920018793, 1025.958961641541, 1030.2221822523945, 1039.3244391145665, 1044.4203467075695, 22840.543189136126, 22960.0, 23122.65316020261, 23245.0, 23481.599904376333, 1106.7233191702076, 1121.994390028061, 1124.3703526025452, 1135.5855112883737, 1143.5711608146944, 12154.392280385946, 12379.266902633639, 12440.875591244152, 12444.128910976146, 12452.875471245352, 242996.0, 245782.0, 246464.0, 246517.0, 246568.0, 50406.2439063407, 50593.0, 50775.746121269156, 50874.236886446735, 50936.23595646068, 1401.3063533550753, 1446.1106419552111, 1456.919869407193, 1457.278647069686, 1467.5744034230167, 22295.331140065824, 22448.775512245324, 22459.887700561394, 22507.774922250566, 22727.0, 36124.27751445009, 36318.27363452769, 36342.0, 36443.63556364403, 36467.45298820573, 195719.0, 195825.0, 195944.0, 196058.0, 196797.0, 32030.67969320277, 32195.839020804746, 32199.51700724444, 32228.0, 32247.0, 39726.0, 42931.35602966021, 44361.33457998068, 44371.556284436745, 44376.0, 31392.686073138975, 31710.68289317077, 31941.36117277595, 32034.35931281408, 32457.0, 32201.35597288088, 32287.0, 32305.676943230268, 32860.34279314448, 33072.834635826664, 36187.45718814167, 36276.81861590781, 36341.81829090838, 36447.0, 36496.45255321226, 31159.221019474695, 31833.840830795696, 31899.68100318967, 32057.0, 32131.19672008125, 22512.5497490046, 24169.033238670258, 24378.51242975166, 24801.62797558002, 25358.590933861255], "value": 16858.69842398335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.2638569859182, 567.9886402271952, 569.8489900176456, 577.7371296060293, 587.1691556447627, 21775.455613609647, 22475.21336753212, 22485.0, 22496.66255006174, 22498.55002899941, 22781.0, 23793.643095353582, 24834.254972350813, 25055.498890022234, 25178.0, 6364.140840986465, 6572.244191917919, 6583.4074933256, 6586.440152587036, 6625.337466253361, 6154.0, 6368.29948705642, 6431.099646049557, 6497.772577959772, 6498.382653647919, 6360.109584658151, 6364.140840986453, 6371.45842603377, 6374.490040796748, 6417.486601071926, 6371.522135839784, 6386.5210109241525, 6422.293547709748, 6435.195600549955, 6445.419912207901, 5955.52355811534, 5956.463918247378, 5973.402659734035, 5974.3726908674835, 5986.161937328778, 28783.985121041536, 29072.563911541343, 29601.70398296011, 29766.70233297661, 29786.0, 1997.5805080933021, 2039.5614942787372, 2044.1312442212, 2045.856790024699, 2046.8669536480081, 19263.51841203967, 19271.614567708708, 19622.313219037263, 19642.80357196424, 20191.09140088685, 2383.475635360218, 2395.652630368587, 2433.221369161869, 2438.9512209755885, 2446.987765061181, 139431.0, 143693.28153359165, 143825.28087359495, 144114.0, 144951.0, 14418.495352662607, 14745.999999999785, 14926.179060151795, 15008.924955375152, 15092.54722358331, 23161.884190578938, 23183.0, 23183.188588399662, 23187.188448404224, 23232.65151022736, 9420.387674801115, 9564.0, 9599.47202903833, 9723.270754693427, 9743.220542356594, 8586.699465518677, 8594.742157735278, 8654.350923680624, 8712.651493940299, 8968.192862642394, 7604.733834315773, 8886.333524985652, 9111.589978450986, 9138.486916098127, 9335.859962100574, 2562.66908923918, 2572.879968861989, 2614.7254538273587, 2627.934301642474, 2669.3860412105323, 956.1108169402384, 978.2760757039881, 990.2820455170088, 992.667456402099, 1007.8891321954579, 19320.0, 19519.8048019518, 19648.115834787182, 20003.399898003085, 23488.412789680395, 998.0618218874235, 1059.819830628795, 1061.0821639281965, 1064.9520771565144, 1077.2836064017497, 10788.730281743019, 11007.504662290215, 11031.503582338813, 11108.944455277671, 11177.0, 489569.0, 492097.0, 492799.0, 493014.0, 495245.0, 118958.40520797341, 125689.0, 125839.0, 126328.36835815945, 126709.36645316714, 1214.7509760499076, 1223.0887988448662, 1262.110212300326, 1273.7261488779957, 1277.0358379423662, 20950.685739714223, 21032.05355758964, 21095.367138985854, 21208.575828483652, 21302.254421095186, 57905.0, 57911.0, 58806.7059664699, 59128.40871591401, 61276.38723612707, 71492.0, 73482.63258683673, 74231.62884185545, 74548.62725686554, 74562.0, 12081.0, 12506.312152831682, 14381.424743010162, 14520.0, 15081.472148474752, 23195.53608927846, 23312.650310245022, 23472.53054938926, 23526.294211173692, 23669.644955326028, 17847.732284015492, 17930.193141308933, 18212.817871821113, 18253.178606962985, 18478.353257635918, 14361.784573231618, 15317.770233446285, 15425.614359641098, 15697.21513924322, 16907.66184676275, 18113.909430452764, 18518.537036574195, 18529.0, 18665.906670467102, 19024.904875476088, 14694.926525367304, 14718.705625887209, 14752.0, 14776.852231477547, 14823.110613363233, 18388.08059596988, 18403.72394414058, 18662.253509859453, 18806.6238675223, 18820.52948676294], "value": 11973.022627370907, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.2069179184282, 1411.55536006158, 1418.333383309844, 1423.6939058102505, 1423.9003269771108, 15070.171140587263, 15708.764368534481, 15713.921430392833, 15726.135062571553, 15731.370745170194, 15847.286872090755, 16149.677006459864, 16172.433964811235, 16179.595510112253, 16184.919075404636, 2648.311439025848, 2767.114523352528, 2802.957955630667, 2805.3968396794685, 2820.873060712273, 2825.9576106358422, 2850.2589326774983, 2859.856057576965, 2859.985700071507, 2871.052552657618, 2751.7523422891936, 2763.3367991682053, 2768.0865314446182, 2773.736495032979, 2824.4351129774022, 2678.317029157562, 2693.0, 2694.2321438389963, 2697.64930559028, 2706.512827691015, 2705.5130076586206, 2727.727227277276, 2732.2622891819096, 2735.302497863052, 2755.3111722069484, 14901.180435076067, 15373.385064597403, 15373.615659608487, 15401.22993850303, 15436.845631543652, 7929.405294602928, 8249.628766705513, 8251.422400431971, 8263.793405164859, 8268.09051004389, 5354.571634269249, 5424.077906755861, 5496.835094947118, 5553.8333849984565, 5588.30146231721, 1798.784145902487, 1807.168702396899, 1814.537292990279, 1838.6230822681453, 1847.436531857783, 24366.0, 24548.0, 24671.259862204162, 24682.0, 24729.381765455826, 7124.750633727795, 7126.5746850630085, 7318.414526837841, 7354.448416368687, 7385.335319821242, 17098.0596067215, 17202.39791607313, 17267.222974966156, 17278.13609319529, 17294.308227671005, 7933.920660793434, 8071.313938315191, 8072.354211663052, 8076.3942704297415, 8076.596170191467, 7438.107427108674, 7454.515456495311, 7490.400767938552, 7508.361789247975, 7535.585542795199, 5075.0, 5250.372384560798, 5251.711155886386, 5287.9471205287455, 5291.444398338196, 1588.2773338131124, 1588.6822635472952, 1591.6657501924494, 1597.1535086404224, 1610.8308627594167, 870.9259712924472, 904.4708845325558, 904.4889637354873, 914.9222316103072, 919.4575200631525, 7335.559866408033, 7409.481336306515, 7413.481056326005, 7414.925850741532, 7472.551646901204, 724.8332883436839, 728.2826415980361, 729.0413106764588, 729.1687476277049, 734.4528326396869, 5282.7622756976025, 5329.333833270841, 5439.347278326626, 5453.100238460689, 5558.416366281563, 20825.479363015744, 21081.683774743393, 21836.89081554614, 21926.122955081937, 22031.559368812854, 21111.050002749915, 21436.892815535823, 21493.78506214949, 21499.247526336814, 21565.24521641735, 10724.302920310154, 11159.330440173615, 11451.88548114525, 11474.94262528682, 11481.885181148082, 8177.0, 8828.690995815115, 8905.154010369004, 9038.367314287936, 9088.636454541744, 18845.811541884406, 19068.237270509024, 19222.231110755412, 19441.0, 19452.124654390303, 18302.542436439195, 18443.354482593044, 18704.251829926652, 19024.42926712201, 19951.501212469804, 12199.939000304941, 12416.130870838955, 12444.875551244371, 12445.25328480294, 12446.377681115728, 13852.16886986784, 14150.504732334319, 14153.150810951376, 14170.645733856323, 14237.21695306768, 11233.775324493628, 11294.43527823622, 11312.547498100314, 11475.540978360772, 11578.247413918069, 10576.259661823598, 10609.575616975235, 10634.042936135786, 10668.8933110671, 10887.292325998786, 9891.901080989099, 10062.647807326708, 10080.798384032132, 10082.647107351208, 10096.444695541815, 7027.789166325018, 7049.929500704928, 7080.079589653312, 7122.964385178041, 7190.820229494305, 7237.059182306267, 7289.1981881994, 7331.78004659861, 7339.669714862737, 7500.699972001059], "value": 6696.644747648272, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.1254398881872, 524.2843518597114, 530.2682298428168, 540.2247774443674, 544.5589072850988, 6283.654399008053, 6333.841653958648, 6355.71399287032, 6371.2991570927215, 6380.808575742735, 6237.438630523252, 6290.1822763040855, 6304.936950630492, 6311.35904664787, 6320.715567799449, 5133.152065256514, 5185.662931909414, 5190.195519694435, 5195.532402083812, 5232.215167724834, 4852.830150944717, 4953.380827396575, 5130.897382052375, 5175.611829112813, 5188.42927278001, 4914.967856750069, 4931.334269873575, 4937.444704917957, 4965.950340496603, 4966.279889416032, 4935.0, 4980.9252861207115, 4984.576311013569, 5018.899622007576, 5037.924431133536, 4481.305397663367, 4515.954840451586, 4536.8865778355475, 4540.77296135192, 4568.406107206075, 6111.694415279218, 6161.537884658668, 6187.690615469209, 6213.347598502138, 6237.750489980395, 5603.831885043455, 5648.943510564883, 5659.971700141514, 5701.6864072476, 5733.226014488033, 6452.64510451925, 6524.967375163142, 6528.869422611569, 6537.280899101095, 6583.6708164592055, 4871.975640121812, 4881.1213981483315, 4881.243407271879, 4883.291922671228, 4905.901881962341, 6675.664867026566, 6734.629595372204, 6794.864102717967, 6831.555948863308, 6876.828079298008, 4859.514048595183, 5008.824691135793, 5013.799448022111, 5033.395992480852, 5055.660250033744, 5049.2426136079885, 5082.110630639623, 5089.9745501272255, 5117.641765076483, 5131.666441681279, 5612.298462692163, 5674.319081710221, 5680.261565996394, 5683.374828768832, 5710.172025056427, 6560.572588142418, 6588.308227636125, 6638.336166383323, 6658.801415745115, 6661.666916654245, 1758.78015248094, 1777.7688900442859, 1779.5373202967062, 1779.9822001779817, 1789.3111152206234, 1154.3766366162347, 1228.3980849383738, 1235.4996226528272, 1238.5293588436516, 1253.354522420954, 5664.801731939362, 5720.570957178145, 5771.624844385102, 5782.190493330937, 5799.971000145057, 6662.800115996528, 6702.692974869854, 6713.362230588086, 6790.660466976631, 6821.2155602106395, 5651.745671444713, 5707.771689132472, 5719.7712091516705, 5740.827775166752, 5799.420057994251, 3499.562554680665, 3540.8047010853434, 3546.3261980223674, 3565.3760591896316, 3590.8025058621506, 6458.838529036811, 6477.57895736785, 6512.023196520559, 6520.315366886409, 6577.0, 6364.459020983176, 6780.660966951633, 6907.861842763116, 6915.930840691629, 6974.616396098162, 6333.271673757485, 6428.5178611604315, 6436.227652681615, 6456.515761317826, 6477.870442591122, 6597.736090556324, 6608.867822643617, 6703.262641109376, 6714.294999025032, 6729.865402691821, 6607.438367738796, 6623.801285961429, 6628.403443690091, 6638.767643132467, 6663.400293973566, 6343.904841427475, 6346.936530634634, 6396.93603063982, 6401.879671057453, 6421.325760795236, 4971.577415919687, 4991.875203119951, 4993.80024799004, 5006.799728010838, 5054.898902022012, 6475.222973243052, 6543.247526534509, 6638.5684930479365, 6662.234507855325, 6797.93202067973, 6411.8717625646295, 6422.743090276524, 6500.967495162494, 6525.608463492205, 6537.378948999837, 6400.359964003563, 6401.55189136756, 6411.326810684811, 6418.010416770816, 6471.870562588816, 6359.332270111571, 6363.172787537776, 6419.518536109717, 6452.096706461193, 6486.124373209556, 6526.24948130971, 6540.574862633914, 6545.770898018546, 6563.0, 6563.507736919654, 6292.2134733158355, 6341.682915854281, 6366.9681651591445, 6382.5532212744665, 6386.371475273962], "value": 5062.770152595206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.8398288308106, 903.8192361527693, 919.7286800393883, 927.5176908007836, 930.8696782450459, 18037.819621803796, 18661.16024778885, 18674.439766806983, 18685.813141868577, 18707.71938420925, 17572.472825815214, 18689.065546722642, 21832.345029649096, 21968.0, 22012.779872201274, 987.2299606307092, 1001.7445551384387, 1005.7234260578363, 1008.1380419741125, 1008.8083264179819, 890.0787684746289, 981.175812317653, 998.7003898830358, 1001.1690297053465, 1002.6190047781869, 1032.7986042721673, 1051.621416290135, 1051.7633532455175, 1052.0216198934988, 1052.5316234275751, 1031.2317323593895, 1044.926855120142, 1048.7849990751877, 1049.2655141401049, 1049.4123290957011, 758.1395116542764, 768.8193274580469, 770.2605498721234, 772.3010675338827, 773.9729109481198, 19842.900785495982, 19857.50356241091, 20184.19263229469, 20245.595088098304, 20354.79645203544, 20958.371248862557, 21037.263695770576, 21477.67783483249, 21512.031958561904, 21609.0, 15265.542033739006, 15849.207539622972, 15891.0, 15899.046057236603, 15913.283902224428, 3760.0411894966883, 3760.2855457462992, 3790.0903783092135, 3800.5819359870393, 3801.6768574671187, 125962.0, 128611.0, 128650.3567482166, 130287.0, 133312.0, 16193.109378984032, 16366.918165409335, 16395.098269595048, 16563.08903010346, 16622.667546648998, 29826.403471930873, 30221.395572088437, 30456.0, 30485.39029219403, 30565.541516877263, 8617.095205003385, 8648.913510864937, 8666.436681615802, 8685.869711954325, 8692.913070869337, 4132.40080188377, 4202.831886724497, 4208.074223670787, 4267.0, 4412.051408947092, 5235.4502777207845, 5333.359996800331, 5349.652272602269, 5350.197470379474, 5372.516473517402, 1023.2121266624657, 1079.6059438304962, 1123.8876112388696, 1134.7276653603242, 1134.9319040857574, 697.424624684627, 709.6061685764347, 714.6926821466819, 721.5057685485459, 736.6537727268176, 12114.8490893365, 12159.392030398445, 12226.938865305616, 12526.0, 12539.811902821464, 672.9024291477708, 684.9280825513349, 695.6799872058808, 706.9151701795714, 711.79713781572, 5875.41245875409, 5885.499732522783, 5890.941090589039, 5925.933332000195, 6007.128966299862, 106228.0, 108932.4553377228, 113281.0, 114144.42927785308, 124934.0, 95005.0, 101098.0, 105299.0, 110910.0, 111697.0, 89200.5539972296, 93694.0, 96194.0, 100049.49975250223, 102660.0, 11791.741185168958, 13239.073264871367, 13340.866591333963, 13431.462741490232, 13477.797833032317, 42308.57691423169, 42750.78624606857, 42762.57237427586, 42972.0, 43829.12341753211, 71991.28008719845, 72797.27202727905, 73162.0, 73283.0, 73654.63172684102, 18008.909955450137, 18869.43391698251, 18884.905575472585, 18907.243710251434, 18917.054147292856, 20286.695699564225, 20753.06611202469, 21262.893685532094, 21417.89291053535, 21801.781982179975, 19317.4204773857, 19607.509812254808, 19614.215431382585, 20019.899900500986, 20175.79824201739, 18757.531061723566, 18829.0, 19162.7125593119, 19303.131359088595, 19544.0, 16926.492205233862, 17059.829401705825, 17226.913865430593, 18915.337963171223, 19360.61278774445, 12901.935490322488, 13967.580972570839, 14255.572332830032, 14263.64340891486, 14931.029483083565, 14239.572812815217, 14684.85315146835, 14784.48254311094, 14839.629009274855, 15396.230188490754], "value": 9369.653649062006, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1490.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 99.0, 108.0, 106.0, 110.0, 108.0, 99.0, 106.0, 109.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 152.0, 191.0, 122.0, 153.0, 145.0, 120.0, 174.0, 119.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 167.0, 163.0, 162.0, 161.0, 166.0, 171.0, 164.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 172.0, 75.0, 75.0, 74.0, 74.0, 162.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 128.0, 79.0, 80.0, 79.0, 129.0, 82.0, 79.0, 133.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 114.0, 113.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 96.0, 95.0, 94.0, 94.0, 95.0, 93.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 54.0, 53.0, 53.0, 53.0, 58.0, 53.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 37.0, 37.0, 39.0, 38.0, 38.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 74.0, 75.0, 75.0, 76.0, 77.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 125.0, 127.0, 116.0, 123.0, 121.0, 117.0, 117.0, 116.0, 165.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 171.0, 180.0, 183.0, 172.0, 176.0, 170.0, 175.0, 170.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 69.0, 64.0], "value": 66.0, "unit": "score"}]}]} 03:40:34 INFO - Return code: 0 03:40:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:34 INFO - # TBPL SUCCESS # 03:40:34 INFO - Running post-action listener: _package_coverage_data 03:40:34 INFO - Running post-action listener: _resource_record_post_action 03:40:34 INFO - [mozharness: 2017-09-06 10:40:34.275160Z] Finished run-tests step (success) 03:40:34 INFO - Running post-run listener: _resource_record_post_run 03:40:34 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393318400; Read time: 12; Write time: 240672 03:40:34 INFO - TinderboxPrint: CPU usage
13.1% 03:40:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:40:34 INFO - TinderboxPrint: I/O write bytes / time
393,318,400 / 240,672 03:40:34 INFO - TinderboxPrint: CPU idle
8,224.1 (86.9%) 03:40:34 INFO - TinderboxPrint: CPU user
1,191.6 (12.6%) 03:40:34 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 98013184; Read time: 0; Write time: 71172 03:40:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:40:34 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285884416; Read time: 12; Write time: 168832 03:40:34 INFO - Running post-run listener: _upload_blobber_files 03:40:34 INFO - Blob upload gear active. 03:40:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:34 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 03:40:34 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'] 03:40:34 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 03:40:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:40:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:40:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:36 INFO - (blobuploader) - INFO - Done attempting. 03:40:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:40 INFO - (blobuploader) - INFO - Done attempting. 03:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:41 INFO - (blobuploader) - INFO - Done attempting. 03:40:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:40:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:40:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:41 INFO - (blobuploader) - INFO - Done attempting. 03:40:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:41 INFO - Return code: 0 03:40:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:41 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290da855a81850108181d40d4f2afd1a3648c401fbfeb036d663fde1a9c0b374a4fa9b475fcce4e0b7357d3253bee1e28637a850aaabb083e6ee8e1cae168d3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cc0e491c9fc7a76a8f10e008b07d752459416d3b3f7677153e12663f706b7db2d821b205c24c6727644cf2b50ddf58a8547fd4e453220e91cde10fdffd8ef4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f308b8e6d9cb01130a4cffadc243e37b43faf9338259ac4b780f4bd4dc89a19de8fb7f072370973189ed267e816dcbafa4c368e53345d21c0ed5bdd9d2e4ce", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7afb1fcced90b289bfb02f384b492cd0127278281f29bdc4d93188d0a70a271f5e3acb3c01a18471cfb8def02e7e1aeca60412f47dacc0b56362197ed22ff6a"} 03:40:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:41 INFO - Contents: 03:40:41 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290da855a81850108181d40d4f2afd1a3648c401fbfeb036d663fde1a9c0b374a4fa9b475fcce4e0b7357d3253bee1e28637a850aaabb083e6ee8e1cae168d3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cc0e491c9fc7a76a8f10e008b07d752459416d3b3f7677153e12663f706b7db2d821b205c24c6727644cf2b50ddf58a8547fd4e453220e91cde10fdffd8ef4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f308b8e6d9cb01130a4cffadc243e37b43faf9338259ac4b780f4bd4dc89a19de8fb7f072370973189ed267e816dcbafa4c368e53345d21c0ed5bdd9d2e4ce", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7afb1fcced90b289bfb02f384b492cd0127278281f29bdc4d93188d0a70a271f5e3acb3c01a18471cfb8def02e7e1aeca60412f47dacc0b56362197ed22ff6a"} 03:40:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:41 INFO - Copying logs to upload dir... 03:40:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.547311 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-06 03:40:42.254589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 03:40:42.261814) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290da855a81850108181d40d4f2afd1a3648c401fbfeb036d663fde1a9c0b374a4fa9b475fcce4e0b7357d3253bee1e28637a850aaabb083e6ee8e1cae168d3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cc0e491c9fc7a76a8f10e008b07d752459416d3b3f7677153e12663f706b7db2d821b205c24c6727644cf2b50ddf58a8547fd4e453220e91cde10fdffd8ef4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f308b8e6d9cb01130a4cffadc243e37b43faf9338259ac4b780f4bd4dc89a19de8fb7f072370973189ed267e816dcbafa4c368e53345d21c0ed5bdd9d2e4ce", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7afb1fcced90b289bfb02f384b492cd0127278281f29bdc4d93188d0a70a271f5e3acb3c01a18471cfb8def02e7e1aeca60412f47dacc0b56362197ed22ff6a"} build_url:https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/290da855a81850108181d40d4f2afd1a3648c401fbfeb036d663fde1a9c0b374a4fa9b475fcce4e0b7357d3253bee1e28637a850aaabb083e6ee8e1cae168d3c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cc0e491c9fc7a76a8f10e008b07d752459416d3b3f7677153e12663f706b7db2d821b205c24c6727644cf2b50ddf58a8547fd4e453220e91cde10fdffd8ef4", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07f308b8e6d9cb01130a4cffadc243e37b43faf9338259ac4b780f4bd4dc89a19de8fb7f072370973189ed267e816dcbafa4c368e53345d21c0ed5bdd9d2e4ce", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7afb1fcced90b289bfb02f384b492cd0127278281f29bdc4d93188d0a70a271f5e3acb3c01a18471cfb8def02e7e1aeca60412f47dacc0b56362197ed22ff6a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 03:40:42.289388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:40:42.292736) ========= 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=9f7544b6a75ada7b6b576032000001a7-1504693195.130835-44736501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:40:42.373261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 03:40:42.376581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 03:40:42.376861) ========= ========= Total master_lag: 0.82 =========