builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-082 starttime: 1504313068.29 results: success (0) revision: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.290006) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.290463) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.290734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.308648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.309020) ========= 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=51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-01 17:44:28-- 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% 45.7M=0s 2017-09-01 17:44:28 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.448631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.448941) ========= 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=51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019917 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:28.498315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 17:44:28.498672) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 --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 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 --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=51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-01 17:44:28,549 truncating revision to first 12 chars 2017-09-01 17:44:28,549 Setting DEBUG logging. 2017-09-01 17:44:28,549 attempt 1/10 2017-09-01 17:44:28,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5278dfcf5eb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-01 17:44:30,075 unpacking tar archive at: mozilla-central-5278dfcf5eb9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.863788 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-01 17:44:30.379033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:30.379333) ========= script_repo_revision: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:30.382826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:30.383095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-01 17:44:30.396098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-01 17:44:30.396497) ========= /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=51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:44:30 INFO - MultiFileLogger online at 20170901 17:44:30 in /builds/slave/test 17:44:30 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 17:44:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:44:30 INFO - {'append_to_log': False, 17:44:30 INFO - 'base_work_dir': '/builds/slave/test', 17:44:30 INFO - 'blob_upload_branch': 'Firefox', 17:44:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:44:30 INFO - 'branch': 'Firefox', 17:44:30 INFO - 'buildbot_json_path': 'buildprops.json', 17:44:30 INFO - 'code_coverage': False, 17:44:30 INFO - 'config_files': ('talos/linux_config.py',), 17:44:30 INFO - 'default_actions': ('clobber', 17:44:30 INFO - 'read-buildbot-config', 17:44:30 INFO - 'download-and-extract', 17:44:30 INFO - 'populate-webroot', 17:44:30 INFO - 'create-virtualenv', 17:44:30 INFO - 'install', 17:44:30 INFO - 'setup-mitmproxy', 17:44:30 INFO - 'run-tests'), 17:44:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:44:30 INFO - 'disable_ccov_upload': False, 17:44:30 INFO - 'disable_stylo': False, 17:44:30 INFO - 'download_minidump_stackwalk': True, 17:44:30 INFO - 'download_symbols': 'ondemand', 17:44:30 INFO - 'enable_stylo': False, 17:44:30 INFO - 'enable_webrender': False, 17:44:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:44:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:44:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:44:30 INFO - 'gecko_profile': False, 17:44:30 INFO - 'gecko_profile_interval': 0, 17:44:30 INFO - 'installer_path': 'installer.exe', 17:44:30 INFO - 'log_level': 'info', 17:44:30 INFO - 'log_name': 'talos', 17:44:30 INFO - 'log_to_console': True, 17:44:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:44:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:44:30 INFO - 'opt_config_files': (), 17:44:30 INFO - 'pip_index': False, 17:44:30 INFO - 'suite': 'dromaeojs-e10s', 17:44:30 INFO - 'system_bits': '32', 17:44:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:44:30 INFO - 'title': 'talos-linux64-ix-082', 17:44:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:44:30 INFO - 'use_talos_json': True, 17:44:30 INFO - 'verify': 'False', 17:44:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:44:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:44:30 INFO - 'work_dir': 'build'} 17:44:30 INFO - [mozharness: 2017-09-02 00:44:30.590294Z] Running clobber step. 17:44:30 INFO - Running pre-action listener: _resource_record_pre_action 17:44:30 INFO - Running main action method: clobber 17:44:30 INFO - rmtree: /builds/slave/test/build 17:44:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:44:31 INFO - Running post-action listener: _resource_record_post_action 17:44:31 INFO - [mozharness: 2017-09-02 00:44:31.605168Z] Finished clobber step (success) 17:44:31 INFO - [mozharness: 2017-09-02 00:44:31.605264Z] Running read-buildbot-config step. 17:44:31 INFO - Running pre-action listener: _resource_record_pre_action 17:44:31 INFO - Running main action method: read_buildbot_config 17:44:31 INFO - Using buildbot properties: 17:44:31 INFO - { 17:44:31 INFO - "project": "", 17:44:31 INFO - "product": "firefox", 17:44:31 INFO - "who": "kwierso@gmail.com", 17:44:31 INFO - "installer_path": "public/build/target.tar.bz2", 17:44:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:44:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:44:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:44:31 INFO - "stage_platform": "linux64-pgo", 17:44:31 INFO - "basedir": "/builds/slave/test", 17:44:31 INFO - "buildnumber": 135, 17:44:31 INFO - "platform": "ubuntu64_hw", 17:44:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:44:31 INFO - "slavebuilddir": "test", 17:44:31 INFO - "taskId": "Dy9m2YYoTl2FTMoAR9Jjdg", 17:44:31 INFO - "branch": "mozilla-central", 17:44:31 INFO - "script_repo_revision": "production", 17:44:31 INFO - "revision": "5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772", 17:44:31 INFO - "slavename": "talos-linux64-ix-082", 17:44:31 INFO - "repo_path": "mozilla-central" 17:44:31 INFO - } 17:44:31 INFO - Finding installer, test and symbols from parent task. 17:44:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dy9m2YYoTl2FTMoAR9Jjdg'}, attempt #1 17:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dy9m2YYoTl2FTMoAR9Jjdg'}, attempt #1 17:44:32 INFO - Task dependencies: FumDpYGRS1uvlCElGgsUMw 17:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw'}, attempt #1 17:44:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2 17:44:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.test_packages.json 17:44:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.crashreporter-symbols.zip 17:44:32 INFO - Running post-action listener: _resource_record_post_action 17:44:32 INFO - [mozharness: 2017-09-02 00:44:32.960418Z] Finished read-buildbot-config step (success) 17:44:32 INFO - [mozharness: 2017-09-02 00:44:32.960674Z] Running download-and-extract step. 17:44:32 INFO - Running pre-action listener: _resource_record_pre_action 17:44:32 INFO - Running main action method: download_and_extract 17:44:32 INFO - mkdir: /builds/slave/test/build/tests 17:44: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')]} 17:44:32 INFO - trying https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.test_packages.json 17:44:32 INFO - Downloading https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:44:33 INFO - Downloaded 989 bytes. 17:44:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:44:33 INFO - Using the following test package requirements: 17:44:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:44:33 INFO - u'common': [u'target.common.tests.zip'], 17:44:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:44:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:44:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:44:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:44:33 INFO - u'mozbase': [u'target.common.tests.zip'], 17:44:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:44:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:44:33 INFO - u'web-platform': [u'target.common.tests.zip', 17:44:33 INFO - u'target.web-platform.tests.tar.gz'], 17:44:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:44:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:44:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.common.tests.zip 17:44:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:44:33 INFO - Fetch https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.common.tests.zip into memory 17:44:34 INFO - Content-Length response header: 55580265 17:44:34 INFO - Bytes received: 55580265 17:44:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.common.tests.zip 17:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.common.tests.zip into memory 17:44:46 INFO - Content-Length response header: 55580265 17:44:46 INFO - Bytes received: 55580265 17:44:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.talos.tests.zip 17:44:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:44:58 INFO - Fetch https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.talos.tests.zip into memory 17:44:59 INFO - Content-Length response header: 14496650 17:44:59 INFO - Bytes received: 14496650 17:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:59 INFO - trying https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2 17:44:59 INFO - Downloading https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:45:00 INFO - Downloaded 63354898 bytes. 17:45:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2 17:45:00 INFO - mkdir: /builds/slave/test/properties 17:45:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:45:00 INFO - Writing to file /builds/slave/test/properties/build_url 17:45:00 INFO - Contents: 17:45:00 INFO - build_url:https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2 17:45:00 INFO - Running post-action listener: _resource_record_post_action 17:45:00 INFO - Running post-action listener: find_tests_for_verification 17:45:00 INFO - Running post-action listener: set_extra_try_arguments 17:45:00 INFO - [mozharness: 2017-09-02 00:45:00.436930Z] Finished download-and-extract step (success) 17:45:00 INFO - [mozharness: 2017-09-02 00:45:00.437026Z] Running populate-webroot step. 17:45:00 INFO - Running pre-action listener: _resource_record_pre_action 17:45:00 INFO - Running main action method: populate_webroot 17:45:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:45:00 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:45:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:45:00 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:45:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:00 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:45:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'tests': ['damp', 'tps']}, 17:45:00 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['damp', 'tps']}, 17:45:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:45:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:45:00 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:45:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:45:00 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:45:00 INFO - 'other-e10s': {'tests': ['a11yr', 17:45:00 INFO - 'ts_paint', 17:45:00 INFO - 'tpaint', 17:45:00 INFO - 'sessionrestore', 17:45:00 INFO - 'sessionrestore_many_windows', 17:45:00 INFO - 'sessionrestore_no_auto_restore', 17:45:00 INFO - 'tabpaint']}, 17:45:00 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['a11yr', 17:45:00 INFO - 'ts_paint', 17:45:00 INFO - 'tpaint', 17:45:00 INFO - 'sessionrestore', 17:45:00 INFO - 'sessionrestore_many_windows', 17:45:00 INFO - 'sessionrestore_no_auto_restore', 17:45:00 INFO - 'tabpaint']}, 17:45:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:45:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:45:00 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['bloom_basic_singleton']}, 17:45:00 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['bloom_basic']}, 17:45:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:45:00 INFO - 'tsvgr_opacity', 17:45:00 INFO - 'tart', 17:45:00 INFO - 'tscrollx', 17:45:00 INFO - 'tsvg_static']}, 17:45:00 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['tsvgx', 17:45:00 INFO - 'tsvgr_opacity', 17:45:00 INFO - 'tart', 17:45:00 INFO - 'tscrollx', 17:45:00 INFO - 'tsvg_static']}, 17:45:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:45:00 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo'], 17:45:00 INFO - 'tests': ['tp5o']}, 17:45:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:45:00 INFO - 'talos_options': ['--mitmproxy', 17:45:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:45:00 INFO - '--firstNonBlankPaint'], 17:45:00 INFO - 'tests': ['tp6_google', 17:45:00 INFO - 'tp6_youtube', 17:45:00 INFO - 'tp6_amazon', 17:45:00 INFO - 'tp6_facebook']}, 17:45:00 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo', 17:45:00 INFO - '--mitmproxy', 17:45:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:45:00 INFO - '--firstNonBlankPaint'], 17:45:00 INFO - 'tests': ['tp6_google', 17:45:00 INFO - 'tp6_youtube', 17:45:00 INFO - 'tp6_amazon', 17:45:00 INFO - 'tp6_facebook']}, 17:45:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo', 17:45:00 INFO - '--stylo-threads=1', 17:45:00 INFO - '--mitmproxy', 17:45:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:45:00 INFO - '--firstNonBlankPaint'], 17:45:00 INFO - 'tests': ['tp6_google', 17:45:00 INFO - 'tp6_youtube', 17:45:00 INFO - 'tp6_amazon', 17:45:00 INFO - 'tp6_facebook']}, 17:45:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'talos_options': ['--xperf_path', 17:45:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:00 INFO - 'tests': ['tp5n']}, 17:45:00 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:45:00 INFO - 'talos_options': ['--enable-stylo', 17:45:00 INFO - '--xperf_path', 17:45:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:45:00 INFO - 'tests': ['tp5n']}}} 17:45:00 INFO - Running post-action listener: _resource_record_post_action 17:45:00 INFO - [mozharness: 2017-09-02 00:45:00.451238Z] Finished populate-webroot step (success) 17:45:00 INFO - [mozharness: 2017-09-02 00:45:00.451327Z] Running create-virtualenv step. 17:45:00 INFO - Running pre-action listener: _resource_record_pre_action 17:45:00 INFO - Running main action method: create_virtualenv 17:45:00 INFO - Creating virtualenv /builds/slave/test/build/venv 17:45:00 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:45:00 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:45:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:45:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:45:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:45:01 INFO - Installing distribute.............................................................................................................................................................................................done. 17:45:01 INFO - Installing pip...............done. 17:45:01 INFO - Return code: 0 17:45:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:45:01 INFO - Reading from file tmpfile_stdout 17:45:01 INFO - Output received: 17:45:01 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:45:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:45:01 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')]} 17:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:01 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')]} 17:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:01 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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:01 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 17:45:01 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 17:45:01 INFO - Using env: {'DISPLAY': ':0', 17:45:01 INFO - 'HOME': '/home/cltbld', 17:45:01 INFO - 'LANG': 'en_US.UTF-8', 17:45:01 INFO - 'LANGUAGE': 'en_US:en', 17:45:01 INFO - 'LOGNAME': 'cltbld', 17:45:01 INFO - 'MAIL': '/var/mail/cltbld', 17:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:01 INFO - 'MOZ_NO_REMOTE': '1', 17:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:01 INFO - 'NO_EM_RESTART': '1', 17:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:01 INFO - 'PWD': '/builds/slave/test', 17:45:01 INFO - 'SHELL': '/bin/bash', 17:45:01 INFO - 'SHLVL': '1', 17:45:01 INFO - 'TERM': 'linux', 17:45:01 INFO - 'TMOUT': '86400', 17:45:01 INFO - 'USER': 'cltbld', 17:45:01 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:01 INFO - '_': '/tools/buildbot/bin/python'} 17:45:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:45:02 INFO - Downloading/unpacking pip>=1.5 17:45:02 INFO - Running setup.py egg_info for package pip 17:45:02 INFO - warning: no files found matching 'pip/cacert.pem' 17:45:02 INFO - warning: no files found matching '*.html' under directory 'docs' 17:45:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:45:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:45:02 INFO - Installing collected packages: pip 17:45:02 INFO - Found existing installation: pip 1.1 17:45:02 INFO - Uninstalling pip: 17:45:02 INFO - Successfully uninstalled pip 17:45:02 INFO - Running setup.py install for pip 17:45:02 INFO - warning: no files found matching 'pip/cacert.pem' 17:45:02 INFO - warning: no files found matching '*.html' under directory 'docs' 17:45:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:45:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:45:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:45:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:45:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:45:02 INFO - Successfully installed pip 17:45:02 INFO - Cleaning up... 17:45:02 INFO - Return code: 0 17:45:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:45:02 INFO - Using env: {'DISPLAY': ':0', 17:45:02 INFO - 'HOME': '/home/cltbld', 17:45:02 INFO - 'LANG': 'en_US.UTF-8', 17:45:02 INFO - 'LANGUAGE': 'en_US:en', 17:45:02 INFO - 'LOGNAME': 'cltbld', 17:45:02 INFO - 'MAIL': '/var/mail/cltbld', 17:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:02 INFO - 'MOZ_NO_REMOTE': '1', 17:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:02 INFO - 'NO_EM_RESTART': '1', 17:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:02 INFO - 'PWD': '/builds/slave/test', 17:45:02 INFO - 'SHELL': '/bin/bash', 17:45:02 INFO - 'SHLVL': '1', 17:45:02 INFO - 'TERM': 'linux', 17:45:02 INFO - 'TMOUT': '86400', 17:45:02 INFO - 'USER': 'cltbld', 17:45:02 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:02 INFO - '_': '/tools/buildbot/bin/python'} 17:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:02 INFO - Downloading/unpacking psutil>=3.1.1 17:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:45:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:04 INFO - Installing collected packages: psutil 17:45:04 INFO - Running setup.py install for psutil 17:45:04 INFO - building 'psutil._psutil_linux' extension 17:45:04 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 17:45:04 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 17:45:04 INFO - building 'psutil._psutil_posix' extension 17:45:04 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 17:45:04 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 17:45:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:45:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:45:04 INFO - Successfully installed psutil 17:45:04 INFO - Cleaning up... 17:45:04 INFO - Return code: 0 17:45:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:45:04 INFO - Using env: {'DISPLAY': ':0', 17:45:04 INFO - 'HOME': '/home/cltbld', 17:45:04 INFO - 'LANG': 'en_US.UTF-8', 17:45:04 INFO - 'LANGUAGE': 'en_US:en', 17:45:04 INFO - 'LOGNAME': 'cltbld', 17:45:04 INFO - 'MAIL': '/var/mail/cltbld', 17:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:04 INFO - 'MOZ_NO_REMOTE': '1', 17:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:04 INFO - 'NO_EM_RESTART': '1', 17:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:04 INFO - 'PWD': '/builds/slave/test', 17:45:04 INFO - 'SHELL': '/bin/bash', 17:45:04 INFO - 'SHLVL': '1', 17:45:04 INFO - 'TERM': 'linux', 17:45:04 INFO - 'TMOUT': '86400', 17:45:04 INFO - 'USER': 'cltbld', 17:45:04 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:04 INFO - '_': '/tools/buildbot/bin/python'} 17:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:45:05 INFO - Installing collected packages: mozsystemmonitor 17:45:05 INFO - Running setup.py install for mozsystemmonitor 17:45:06 INFO - Successfully installed mozsystemmonitor 17:45:06 INFO - Cleaning up... 17:45:06 INFO - Return code: 0 17:45:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:45:06 INFO - Using env: {'DISPLAY': ':0', 17:45:06 INFO - 'HOME': '/home/cltbld', 17:45:06 INFO - 'LANG': 'en_US.UTF-8', 17:45:06 INFO - 'LANGUAGE': 'en_US:en', 17:45:06 INFO - 'LOGNAME': 'cltbld', 17:45:06 INFO - 'MAIL': '/var/mail/cltbld', 17:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:06 INFO - 'MOZ_NO_REMOTE': '1', 17:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:06 INFO - 'NO_EM_RESTART': '1', 17:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:06 INFO - 'PWD': '/builds/slave/test', 17:45:06 INFO - 'SHELL': '/bin/bash', 17:45:06 INFO - 'SHLVL': '1', 17:45:06 INFO - 'TERM': 'linux', 17:45:06 INFO - 'TMOUT': '86400', 17:45:06 INFO - 'USER': 'cltbld', 17:45:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:06 INFO - '_': '/tools/buildbot/bin/python'} 17:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:06 INFO - Downloading/unpacking jsonschema==2.5.1 17:45:06 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 17:45:06 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 17:45:06 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 17:45:06 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 17:45:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:45:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:45:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:45:07 INFO - warning: no files found matching '*.txt' 17:45:07 INFO - no previously-included directories found matching 'build' 17:45:07 INFO - no previously-included directories found matching 'dist' 17:45:07 INFO - no previously-included directories found matching '.git*' 17:45:07 INFO - Installing collected packages: jsonschema, functools32 17:45:07 INFO - Running setup.py install for functools32 17:45:07 INFO - warning: no files found matching '*.txt' 17:45:07 INFO - no previously-included directories found matching 'build' 17:45:07 INFO - no previously-included directories found matching 'dist' 17:45:07 INFO - no previously-included directories found matching '.git*' 17:45:07 INFO - Successfully installed jsonschema functools32 17:45:07 INFO - Cleaning up... 17:45:07 INFO - Return code: 0 17:45:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:45:07 INFO - Using env: {'DISPLAY': ':0', 17:45:07 INFO - 'HOME': '/home/cltbld', 17:45:07 INFO - 'LANG': 'en_US.UTF-8', 17:45:07 INFO - 'LANGUAGE': 'en_US:en', 17:45:07 INFO - 'LOGNAME': 'cltbld', 17:45:07 INFO - 'MAIL': '/var/mail/cltbld', 17:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:07 INFO - 'MOZ_NO_REMOTE': '1', 17:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:07 INFO - 'NO_EM_RESTART': '1', 17:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:07 INFO - 'PWD': '/builds/slave/test', 17:45:07 INFO - 'SHELL': '/bin/bash', 17:45:07 INFO - 'SHLVL': '1', 17:45:07 INFO - 'TERM': 'linux', 17:45:07 INFO - 'TMOUT': '86400', 17:45:07 INFO - 'USER': 'cltbld', 17:45:07 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:07 INFO - '_': '/tools/buildbot/bin/python'} 17:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:45:07 INFO - Cleaning up... 17:45:07 INFO - Return code: 0 17:45:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:45:07 INFO - Using env: {'DISPLAY': ':0', 17:45:07 INFO - 'HOME': '/home/cltbld', 17:45:08 INFO - 'LANG': 'en_US.UTF-8', 17:45:08 INFO - 'LANGUAGE': 'en_US:en', 17:45:08 INFO - 'LOGNAME': 'cltbld', 17:45:08 INFO - 'MAIL': '/var/mail/cltbld', 17:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:08 INFO - 'MOZ_NO_REMOTE': '1', 17:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:08 INFO - 'NO_EM_RESTART': '1', 17:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:08 INFO - 'PWD': '/builds/slave/test', 17:45:08 INFO - 'SHELL': '/bin/bash', 17:45:08 INFO - 'SHLVL': '1', 17:45:08 INFO - 'TERM': 'linux', 17:45:08 INFO - 'TMOUT': '86400', 17:45:08 INFO - 'USER': 'cltbld', 17:45:08 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:08 INFO - '_': '/tools/buildbot/bin/python'} 17:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:08 INFO - Downloading/unpacking blobuploader==1.2.4 17:45:08 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 17:45:08 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 17:45:08 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 17:45:08 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 17:45:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:45:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:45:16 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 17:45:16 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 17:45:16 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 17:45:16 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 17:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:45:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:45:16 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 17:45:16 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 17:45:16 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 17:45:16 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 17:45:16 INFO - Downloading docopt-0.6.1.tar.gz 17:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:45:16 INFO - Installing collected packages: blobuploader, requests, docopt 17:45:16 INFO - Running setup.py install for blobuploader 17:45:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:45:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:45:17 INFO - Running setup.py install for requests 17:45:17 INFO - Running setup.py install for docopt 17:45:17 INFO - Successfully installed blobuploader requests docopt 17:45:17 INFO - Cleaning up... 17:45:17 INFO - Return code: 0 17:45:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:17 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')]} 17:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:17 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')]} 17:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:17 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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:17 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 17:45:17 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 17:45:17 INFO - Using env: {'DISPLAY': ':0', 17:45:17 INFO - 'HOME': '/home/cltbld', 17:45:17 INFO - 'LANG': 'en_US.UTF-8', 17:45:17 INFO - 'LANGUAGE': 'en_US:en', 17:45:17 INFO - 'LOGNAME': 'cltbld', 17:45:17 INFO - 'MAIL': '/var/mail/cltbld', 17:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:17 INFO - 'MOZ_NO_REMOTE': '1', 17:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:17 INFO - 'NO_EM_RESTART': '1', 17:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:17 INFO - 'PWD': '/builds/slave/test', 17:45:17 INFO - 'SHELL': '/bin/bash', 17:45:17 INFO - 'SHLVL': '1', 17:45:17 INFO - 'TERM': 'linux', 17:45:17 INFO - 'TMOUT': '86400', 17:45:17 INFO - 'USER': 'cltbld', 17:45:17 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:17 INFO - '_': '/tools/buildbot/bin/python'} 17:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:17 INFO - Running setup.py (path:/tmp/pip-7vKDWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:17 INFO - Running setup.py (path:/tmp/pip-j09cqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:17 INFO - Running setup.py (path:/tmp/pip-Yxf839-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:17 INFO - Running setup.py (path:/tmp/pip-ThHgfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:18 INFO - Running setup.py (path:/tmp/pip-5G3yF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:18 INFO - Running setup.py (path:/tmp/pip-hrXiXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:18 INFO - Running setup.py (path:/tmp/pip-0gJduz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:18 INFO - Running setup.py (path:/tmp/pip-oJ0SSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:18 INFO - Running setup.py (path:/tmp/pip-j1bUz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:18 INFO - Running setup.py (path:/tmp/pip-37T2JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:18 INFO - Running setup.py (path:/tmp/pip-_qFYAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:18 INFO - Running setup.py (path:/tmp/pip-Y4tSou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:18 INFO - Running setup.py (path:/tmp/pip-mDkh8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:18 INFO - Running setup.py (path:/tmp/pip-WI1rfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:18 INFO - Running setup.py (path:/tmp/pip-XmqrEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:18 INFO - Running setup.py (path:/tmp/pip-_ejoDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:18 INFO - Running setup.py (path:/tmp/pip-yYlUAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:45:18 INFO - Running setup.py install for manifestparser 17:45:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Running setup.py install for mozcrash 17:45:19 INFO - Running setup.py install for mozdebug 17:45:19 INFO - Running setup.py install for mozdevice 17:45:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Running setup.py install for mozfile 17:45:19 INFO - Running setup.py install for mozhttpd 17:45:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Running setup.py install for mozinfo 17:45:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Running setup.py install for mozInstall 17:45:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Running setup.py install for mozleak 17:45:19 INFO - Running setup.py install for mozlog 17:45:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:45:19 INFO - Running setup.py install for moznetwork 17:45:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:45:20 INFO - Running setup.py install for mozprocess 17:45:20 INFO - Running setup.py install for mozprofile 17:45:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:45:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:45:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:45:20 INFO - Running setup.py install for mozrunner 17:45:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:45:20 INFO - Running setup.py install for mozscreenshot 17:45:20 INFO - Running setup.py install for moztest 17:45:20 INFO - Running setup.py install for mozversion 17:45:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:45:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:45:20 INFO - Cleaning up... 17:45:20 INFO - Return code: 0 17:45:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:20 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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:20 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 17:45:20 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 17:45:20 INFO - Using env: {'DISPLAY': ':0', 17:45:20 INFO - 'HOME': '/home/cltbld', 17:45:20 INFO - 'LANG': 'en_US.UTF-8', 17:45:20 INFO - 'LANGUAGE': 'en_US:en', 17:45:20 INFO - 'LOGNAME': 'cltbld', 17:45:20 INFO - 'MAIL': '/var/mail/cltbld', 17:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:20 INFO - 'MOZ_NO_REMOTE': '1', 17:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:20 INFO - 'NO_EM_RESTART': '1', 17:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:20 INFO - 'PWD': '/builds/slave/test', 17:45:20 INFO - 'SHELL': '/bin/bash', 17:45:20 INFO - 'SHLVL': '1', 17:45:20 INFO - 'TERM': 'linux', 17:45:20 INFO - 'TMOUT': '86400', 17:45:20 INFO - 'USER': 'cltbld', 17:45:20 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:20 INFO - '_': '/tools/buildbot/bin/python'} 17:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:45:20 INFO - Running setup.py (path:/tmp/pip-eyxjyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:45:20 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)) 17:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:45:20 INFO - Running setup.py (path:/tmp/pip-W2WtvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:45:21 INFO - Running setup.py (path:/tmp/pip-Qwf0xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:45:21 INFO - Running setup.py (path:/tmp/pip-PPrPv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:45:21 INFO - Running setup.py (path:/tmp/pip-NXRLrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:45:21 INFO - Running setup.py (path:/tmp/pip-77lNyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:45:21 INFO - Running setup.py (path:/tmp/pip-zpRSBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:45:21 INFO - Running setup.py (path:/tmp/pip-yrMJgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:45:21 INFO - Running setup.py (path:/tmp/pip-DPtAwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:45:21 INFO - Running setup.py (path:/tmp/pip-JuTu5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:45:21 INFO - Running setup.py (path:/tmp/pip-RjRD4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:45:21 INFO - Running setup.py (path:/tmp/pip-JkOxBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:45:21 INFO - Running setup.py (path:/tmp/pip-Ue9xZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:45:21 INFO - Running setup.py (path:/tmp/pip-BoDM6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:21 INFO - Running setup.py (path:/tmp/pip-v5Rc8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:45:21 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)) 17:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:45:21 INFO - Running setup.py (path:/tmp/pip-ckesiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:45:22 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)) 17:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:45:22 INFO - Running setup.py (path:/tmp/pip-pOlHI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:45:22 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)) 17:45:22 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)) 17:45:22 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)) 17:45:22 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)) 17:45:22 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)) 17:45:22 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)) 17:45:22 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)) 17:45:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:45:22 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 17:45:22 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 17:45:22 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 17:45:22 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 17:45:23 INFO - Downloading blessings-1.6.tar.gz 17:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:45:23 INFO - Installing collected packages: blessings 17:45:23 INFO - Running setup.py install for blessings 17:45:23 INFO - Successfully installed blessings 17:45:23 INFO - Cleaning up... 17:45:23 INFO - Return code: 0 17:45:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:45:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:23 INFO - Reading from file tmpfile_stdout 17:45:23 INFO - Current package versions: 17:45:23 INFO - argparse == 1.2.1 17:45:23 INFO - blessings == 1.6 17:45:23 INFO - blobuploader == 1.2.4 17:45:23 INFO - docopt == 0.6.1 17:45:23 INFO - functools32 == 3.2.3-2 17:45:23 INFO - jsonschema == 2.5.1 17:45:23 INFO - manifestparser == 1.1 17:45:23 INFO - mozInstall == 1.13 17:45:23 INFO - mozcrash == 1.0 17:45:23 INFO - mozdebug == 0.1 17:45:23 INFO - mozdevice == 0.51 17:45:23 INFO - mozfile == 1.2 17:45:23 INFO - mozhttpd == 0.7 17:45:23 INFO - mozinfo == 0.10 17:45:23 INFO - mozleak == 0.1 17:45:23 INFO - mozlog == 3.5 17:45:23 INFO - moznetwork == 0.27 17:45:23 INFO - mozprocess == 0.25 17:45:23 INFO - mozprofile == 0.28 17:45:23 INFO - mozrunner == 6.13 17:45:23 INFO - mozscreenshot == 0.1 17:45:23 INFO - mozsystemmonitor == 0.3 17:45:23 INFO - moztest == 0.8 17:45:23 INFO - mozversion == 1.4 17:45:23 INFO - psutil == 3.1.1 17:45:23 INFO - requests == 1.2.3 17:45:23 INFO - wsgiref == 0.1.2 17:45:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:23 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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:23 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 17:45:23 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 17:45:23 INFO - Using env: {'DISPLAY': ':0', 17:45:23 INFO - 'HOME': '/home/cltbld', 17:45:23 INFO - 'LANG': 'en_US.UTF-8', 17:45:23 INFO - 'LANGUAGE': 'en_US:en', 17:45:23 INFO - 'LOGNAME': 'cltbld', 17:45:23 INFO - 'MAIL': '/var/mail/cltbld', 17:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:23 INFO - 'MOZ_NO_REMOTE': '1', 17:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:23 INFO - 'NO_EM_RESTART': '1', 17:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:23 INFO - 'PWD': '/builds/slave/test', 17:45:23 INFO - 'SHELL': '/bin/bash', 17:45:23 INFO - 'SHLVL': '1', 17:45:23 INFO - 'TERM': 'linux', 17:45:23 INFO - 'TMOUT': '86400', 17:45:23 INFO - 'USER': 'cltbld', 17:45:23 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:23 INFO - '_': '/tools/buildbot/bin/python'} 17:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 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)) 17:45:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:45:23 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 17:45:23 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 17:45:23 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 17:45:23 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 17:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:45:25 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)) 17:45:25 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)) 17:45:25 INFO - Installing collected packages: simplejson 17:45:25 INFO - Running setup.py install for simplejson 17:45:25 INFO - building 'simplejson._speedups' extension 17:45:25 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 17:45:25 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 17:45:26 INFO - Successfully installed simplejson 17:45:26 INFO - Cleaning up... 17:45:26 INFO - Return code: 0 17:45:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:45: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')]} 17:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:45: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')]} 17:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:45:26 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 0x26911f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29fda60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, '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': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', '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 17:45:26 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 17:45:26 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 17:45:26 INFO - Using env: {'DISPLAY': ':0', 17:45:26 INFO - 'HOME': '/home/cltbld', 17:45:26 INFO - 'LANG': 'en_US.UTF-8', 17:45:26 INFO - 'LANGUAGE': 'en_US:en', 17:45:26 INFO - 'LOGNAME': 'cltbld', 17:45:26 INFO - 'MAIL': '/var/mail/cltbld', 17:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:26 INFO - 'MOZ_NO_REMOTE': '1', 17:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:26 INFO - 'NO_EM_RESTART': '1', 17:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:26 INFO - 'PWD': '/builds/slave/test', 17:45:26 INFO - 'SHELL': '/bin/bash', 17:45:26 INFO - 'SHLVL': '1', 17:45:26 INFO - 'TERM': 'linux', 17:45:26 INFO - 'TMOUT': '86400', 17:45:26 INFO - 'USER': 'cltbld', 17:45:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:26 INFO - '_': '/tools/buildbot/bin/python'} 17:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:45:26 INFO - Cleaning up... 17:45:26 INFO - Return code: 0 17:45:26 INFO - Running post-action listener: _resource_record_post_action 17:45:26 INFO - Running post-action listener: _start_resource_monitoring 17:45:26 INFO - Starting resource monitoring. 17:45:26 INFO - [mozharness: 2017-09-02 00:45:26.322649Z] Finished create-virtualenv step (success) 17:45:26 INFO - [mozharness: 2017-09-02 00:45:26.323164Z] Running install step. 17:45:26 INFO - Running pre-action listener: _resource_record_pre_action 17:45:26 INFO - Running main action method: install 17:45:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:45:26 INFO - Reading from file tmpfile_stdout 17:45:26 INFO - Detecting whether we're running mozinstall >=1.0... 17:45:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:45:26 INFO - Reading from file tmpfile_stdout 17:45:26 INFO - Output received: 17:45:26 INFO - Usage: mozinstall [options] installer 17:45:26 INFO - Options: 17:45:26 INFO - -h, --help show this help message and exit 17:45:26 INFO - -d DEST, --destination=DEST 17:45:26 INFO - Directory to install application into. [default: 17:45:26 INFO - "/builds/slave/test"] 17:45:26 INFO - --app=APP Application being installed. [default: firefox] 17:45:26 INFO - mkdir: /builds/slave/test/build/application 17:45:26 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'] 17:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:45:42 INFO - Reading from file tmpfile_stdout 17:45:42 INFO - Output received: 17:45:42 INFO - /builds/slave/test/build/application/firefox/firefox 17:45:42 INFO - Running post-action listener: _resource_record_post_action 17:45:42 INFO - [mozharness: 2017-09-02 00:45:42.966922Z] Finished install step (success) 17:45:42 INFO - [mozharness: 2017-09-02 00:45:42.967173Z] Running setup-mitmproxy step. 17:45:42 INFO - Running pre-action listener: _resource_record_pre_action 17:45:42 INFO - Running main action method: setup_mitmproxy 17:45:42 INFO - Skipping: mitmproxy is not required 17:45:42 INFO - Running post-action listener: _resource_record_post_action 17:45:42 INFO - [mozharness: 2017-09-02 00:45:42.968295Z] Finished setup-mitmproxy step (success) 17:45:42 INFO - [mozharness: 2017-09-02 00:45:42.968569Z] Running run-tests step. 17:45:42 INFO - Running pre-action listener: _resource_record_pre_action 17:45:42 INFO - Running pre-action listener: _set_gcov_prefix 17:45:42 INFO - Running main action method: run_tests 17:45:42 WARNING - Try message not found. 17:45:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:45:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:45:42 INFO - Python 2.7.3 17:45:42 INFO - Return code: 0 17:45:42 INFO - grabbing minidump binary from tooltool 17:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:42 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 0x2a01090>, '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 0x2a01d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29fbf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:45:42 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 17:45:42 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 17:45:42 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 17:45:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:45:43 INFO - Return code: 0 17:45:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:45:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:45:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:45:43 INFO - ENV: RUST_BACKTRACE is now full 17:45:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:45:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:45:43 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/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 17:45:43 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/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 17:45:43 INFO - Using env: {'DISPLAY': ':0', 17:45:43 INFO - 'HOME': '/home/cltbld', 17:45:43 INFO - 'LANG': 'en_US.UTF-8', 17:45:43 INFO - 'LANGUAGE': 'en_US:en', 17:45:43 INFO - 'LOGNAME': 'cltbld', 17:45:43 INFO - 'MAIL': '/var/mail/cltbld', 17:45:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:43 INFO - 'MOZ_NO_REMOTE': '1', 17:45:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:43 INFO - 'NO_EM_RESTART': '1', 17:45:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:43 INFO - 'PWD': '/builds/slave/test', 17:45:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:43 INFO - 'RUST_BACKTRACE': 'full', 17:45:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:45:43 INFO - 'SHELL': '/bin/bash', 17:45:43 INFO - 'SHLVL': '1', 17:45:43 INFO - 'TERM': 'linux', 17:45:43 INFO - 'TMOUT': '86400', 17:45:43 INFO - 'USER': 'cltbld', 17:45:43 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:43 INFO - '_': '/tools/buildbot/bin/python'} 17:45:43 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/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 17:45:43 INFO - mozversion application_buildid: 20170901232924 17:45:43 INFO - mozversion application_changeset: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 17:45:43 INFO - mozversion application_display_name: Nightly 17:45:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:45:43 INFO - mozversion application_name: Firefox 17:45:43 INFO - mozversion application_remotingname: firefox 17:45:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:45:43 INFO - mozversion application_vendor: Mozilla 17:45:43 INFO - mozversion application_version: 57.0a1 17:45:43 INFO - mozversion platform_buildid: 20170901232924 17:45:43 INFO - mozversion platform_changeset: 5278dfcf5eb9f58eaf06ad1ce67e7fd4aba34772 17:45:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:45:43 INFO - mozversion platform_version: 57.0a1 17:45:43 INFO - using testdate: 1504313143 17:45:43 INFO - actual date: 1504313143 17:45:43 INFO - starting webserver on 'localhost:58739' 17:45:43 INFO - SUITE-START | Running 2 tests 17:45:43 INFO - TEST-START | dromaeo_css 17:45:43 INFO - Initialising browser for dromaeo_css test... 17:45:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58739/getInfo.html -profile /tmp/tmpCLML0a/profile 17:45:43 INFO - TEST-INFO | started process 7575 (/builds/slave/test/build/application/firefox/firefox http://localhost:58739/getInfo.html) 17:45:48 INFO - TEST-INFO | 7575: exit 0 17:45:48 INFO - Browser initialized. 17:45:48 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:48 INFO - Using env: {'DISPLAY': ':0', 17:45:48 INFO - 'HOME': '/home/cltbld', 17:45:48 INFO - 'JSGC_DISABLE_POISONING': '1', 17:45:48 INFO - 'LANG': 'en_US.UTF-8', 17:45:48 INFO - 'LANGUAGE': 'en_US:en', 17:45:48 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:45:48 INFO - 'LOGNAME': 'cltbld', 17:45:48 INFO - 'MAIL': '/var/mail/cltbld', 17:45:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:45:48 INFO - 'MOZ_CRASHREPORTER': '1', 17:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:48 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:45:48 INFO - 'MOZ_NO_REMOTE': '1', 17:45:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:45:48 INFO - 'NO_EM_RESTART': '1', 17:45:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:48 INFO - 'PWD': '/builds/slave/test', 17:45:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:48 INFO - 'RUST_BACKTRACE': 'full', 17:45:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:45:48 INFO - 'SHELL': '/bin/bash', 17:45:48 INFO - 'SHLVL': '1', 17:45:48 INFO - 'TERM': 'linux', 17:45:48 INFO - 'TMOUT': '86400', 17:45:48 INFO - 'USER': 'cltbld', 17:45:48 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 17:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:48 INFO - '_': '/tools/buildbot/bin/python'} 17:45:48 INFO - TEST-INFO | started process 7760 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCLML0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:49 INFO - PID 7760 | 17:45:49 INFO - PID 7760 | (/builds/slave/test/build/application/firefox/firefox:7812): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:45:49 INFO - PID 7760 | 17:45:59 INFO - PID 7760 | RSS: Main: 162611200 17:45:59 INFO - PID 7760 | 17:48:58 INFO - PID 7760 | Cycle 1(1): loaded http://localhost:58739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58739/tests/dromaeo/cssquery-ext.html) 17:48:59 INFO - PID 7760 | RSS: Main: 165724160 17:48:59 INFO - PID 7760 | 17:52:00 INFO - PID 7760 | Cycle 1(1): loaded http://localhost:58739/tests/dromaeo/cssquery-ext.html (next: http://localhost:58739/tests/dromaeo/cssquery-jquery.html) 17:52:01 INFO - PID 7760 | RSS: Main: 161710080 17:52:01 INFO - PID 7760 | 17:55:03 INFO - PID 7760 | Cycle 1(1): loaded http://localhost:58739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58739/tests/dromaeo/cssquery-mootools.html) 17:55:03 INFO - PID 7760 | RSS: Main: 164102144 17:55:03 INFO - PID 7760 | 17:58:05 INFO - PID 7760 | Cycle 1(1): loaded http://localhost:58739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58739/tests/dromaeo/cssquery-prototype.html) 17:58:05 INFO - PID 7760 | RSS: Main: 162824192 17:58:05 INFO - PID 7760 | 18:01:09 INFO - PID 7760 | Cycle 1(1): loaded http://localhost:58739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58739/tests/dromaeo/cssquery-yui.html) 18:01:10 INFO - PID 7760 | RSS: Main: 163565568 18:01:10 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | Cycle 1(1): loaded http://localhost:58739/tests/dromaeo/cssquery-yui.html (next: http://localhost:58739/tests/dromaeo/cssquery-dojo.html) 18:04:11 INFO - PID 7760 | RSS: Main: 166653952 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | __start_tp_report 18:04:11 INFO - PID 7760 | _x_x_mozilla_page_load 18:04:11 INFO - PID 7760 | _x_x_mozilla_page_load_details 18:04:11 INFO - PID 7760 | |i|pagename|runs| 18:04:11 INFO - PID 7760 | |0;dojo.html;3866.8259928303205;3920.3139450596145;3920.882373528794;3922.705797065217;3941.8029098545085;6822.522423430361;6857.279985601514;6870.82822929427;6912.792616221515;6921.7577384791475;6669.866602667944;6731.56244844086;6733.091032710583;6736.326367363261;6772.221194562627;6040.909386359186;6053.969730151354;6074.179985701918;6111.144439778434;6189.81430557084;6259.874802503947;6263.373662633723;6275.215598050244;6283.874322513547;6291.937080629181;6096.908546371808;6143.508519318444;6224.813255602339;6235.594686345373;6243.906341404882;5809.7676092956235;5953.28560572734;6150.753969841201;6181.07283907413;6217;6108.236470441195;6121.816345509642;6196.163517925068;6200.224971878515;6237.656928868911;6805.217399999014;6813.420859226922;6866.244713081557;6908.378245957838;6930.3762661360215;7415.406767458644;7432.405407567381;7487.438442116863;7543.73596924105;7554.69781208751;7275.381592564639;7514.4364172687265;7521.661525231378;7614.543127412373;7623.009008828817;6817.488688348394;6888.104546408985;6946.340097690711;6948.200956889972;6948.895766563505;7662.272084151997;7688.077430708351;7761.223877612307;7779.260970207822;7810.570418626917;7243.601601911945;7363.190049094595;7383.8154046149275;7468.439867009996;7478.476506644592;7262.5642461451425;7355.816104597321;7482.925170748332;7550.433717471212;7581.203973582805;7392.44556658242;7438;7542.358899493604;7563.432742544332;7567.091948966159;7480.990066341084;7484.214157513492;7490.550566966;7593.316601505891;7616.9238307616215;6147.200863887666;6356.45970092538;6406.199225096863;6487.578307410097;6489.967550162219;5334.11987022137;5357.651752636066;5463.043967305705;5504.972475137599;5575.972120139373;6223.502119830403;6361.332060133619;6373.3945275198785;6374.298827129012;6377.904331435032;7439.851202976019;7448.4041276697735;7506.3244308012545;7531.585762783099;7540;6100.420460056376;6180.938190618036;6298.307186209513;6320;6362.141110950055;6702.229243637044;6786.796396108125;6799.048133261347;6801.591904485746;6807.829804254933;7110.822229444202;7171.211166771755;7253.8549229015125;7272.163701174432;7295.744648937261;7152.284771522806;7203.819904502429;7383.556986580822;7417.777466676009;7495.88756168647;7288.562686238843;7297.890531641923;7314.012608297811;7318.707251709872;7319.4144468443465;7352.191258961617;7369.89259080527;7387.076615423072;7406.333429991327;7505.362044226302;7166.1400631922415;7297.160826504807;7414.295641914009;7517.361024312776;7540.0951885771865;7140.357367836919;7175.928240717735;7185.856282874418;7191.065161528968;7210.89183662235;6998.825029374307;7084.504084714226;7145.321194486515;7183.066201393785;7193.71225151009;6908.827279317856;7022.227554969051;7106.076210092655;7111.359977602041;7210.675519601736;7004.684789184601;7162.641867906688;7274.454415918933;7284.67218975158;7290.9635451822405;6895.55178913369;6956.826079348057;6991.916252980796;7003.4397248219;7117.217106118426 18:04:11 INFO - PID 7760 | |1;ext.html;899.9640014399422;925.7639301977995;945.8155659646369;977.208461146471;977.5356705564853;40899.59100408995;41765.95585110374;41855.58144418555;41884.37173442401;41893.58106418935;38829.41755873657;39024.609753902456;39082;39148;39229;7144.749933752332;7308.707651693926;7317.5609463432365;7348;7355.37479314259;7217.819554511153;7264.164621068566;7275.490715649907;7299.963500182518;7304.561726296412;7208.49540532163;7854.646540905673;8066.71766488173;8067.677292908306;8076.555789431579;7978.960105199466;8012.5192488450875;8046.114927357986;8047.195280471965;8054.7180848670305;7685.23147685227;7890.605469726548;7894.171112033268;7917.524948503108;7924.881126783045;38828.41757373614;39118.60881391178;39182.60817391818;39218.803905980574;39544.20911581781;3697.5008373869723;3745.662890339855;3747.194353214045;3749.1939233065023;3749.4000959846294;32307.676923230938;32388.190295242573;32429.35141297161;32464.837675811705;32664.510032349535;5483.396826349099;5493.725313734337;5508.476694713996;5535.25274087997;5537.418571050022;204580;206321;206802;209089;243681;48453.27320090131;49194.75402623036;49262.753686232056;49343.50656493461;49366.25950610744;52118.739406302724;52355.47644523582;52372;52463;52505.7374713124;14400.567982960529;14478.638034049232;14498.782518262235;14504.637384065272;14512;11451.713707157387;11474.54101835934;11478.19652624325;11580.073594112619;11586.304821710724;14194.077384969944;14198.85801141996;14257.215853128178;14274.14355138695;14284.928575357264;5652.123920792284;5680.857978550569;5712.343080545707;5756.65460072397;5770.816982518658;1070.4380200394855;1078.5739632844982;1093.3221402730358;1098.5825386353135;1113.821788513834;22939.37507780406;23026.884865575565;23075.653865192035;23144.189953351553;23665;1178.8762179971152;1179.622520793355;1186.6202815099086;1189.547971770739;1190.4999900042003;12558;12786.61640150797;12877.162984405984;12948;12976.221426714428;279782;280448;282215;282324;282373;52980.47019529832;53382;53724.73137634287;53730.73134634302;53956.46043539593;1446.522647526314;1479.8446163152714;1489.4637930345068;1508.9170095644845;1513.311443293299;21628.45928851791;21674;21728.67406988865;22364.217252396087;22806.31581052571;39480.2103957925;39610.80194599008;39661.60338396579;39696.80151599339;39743.60256397399;226146;226363;226518;227050;227504;34094.147646309044;34735.652643473244;35164;35344.82327588346;35404;43574.56425435705;44179;44201.11597767963;44315.77842110769;44584.331235030855;32870.835645821615;33071.834640826644;33359;33529.49705754464;33661.32677346488;32775.67224327726;33387.666123339426;33434.832825835714;33520.83239583787;33781;38180.23639527249;38251.2349753009;38268.80865595654;38645.80677096709;38663;32055.67944320527;32363;32368;32384.514232286063;32487.512687309238;24089.51820963606;24373.51252974966;24443.633345500188;24740.25779226626;25056 18:04:11 INFO - PID 7760 | |2;jquery.html;577.2207519848203;579.5827004556718;590.5216774412726;595.961262517936;603.4086595136765;22900.312990610266;23323;23862.76137238627;23877.28368148956;23899.761002389972;24209.152679656214;24497.877510612467;24688.87655561724;24738.505229895392;24746.25761227166;6844.82887927802;7007.544509606859;7011.789646310619;7014.824629384255;7020.894686579705;6425.678716064202;6779.728810847585;6786.491013174007;6787;6792.0830687857;6721.596704197739;6749.2913244109395;6762.019507171482;6768.018637297589;6768.492363072764;6738;6751.358620931003;6754.2907994660345;6755.966220168917;6759.256481787;6270.811875643738;6294.370562943669;6297.244330680348;6298.2442106947;6304.905426418607;28868.566971495446;30586;30918.69081309203;31098.844505777328;31103;2277.794998450131;2304.20504925802;2307.157887371114;2308.7114110736156;2313.3291345509783;19895.701564476545;20704.275350362666;20711.58576828455;20746.48133796652;20749.273775417787;2489.514544663791;2491.6262560615874;2546.121588052119;2576.0726138590094;2582.14789119592;155994;163415;163605;164123;164148;16314.26585803618;16482.175891205392;16522.339106435607;16749.07880066608;16979.23593438298;25808.48383032329;25811.741882580933;25825.870870645904;25834.095806647052;25842.35394115162;9876.40741555509;10056.34633748804;10193.592256309665;10227;10229.846552301722;9106.635734570675;9118.954405228063;9125.589348479334;9187.908120918706;9202.769930751785;9870.21038316933;9876.888780034265;10080.445575493419;10117.645882394081;10265.486725663686;2938.617979662673;2966.5401862711315;3001.654809696869;3013.984930075336;3083.2291927018246;1017.8880323164447;1023.2070145637191;1039.616049758048;1040.8230600797883;1046.6441409920512;19875.801241987396;25741.22776316676;27123.050693226036;27386.041488547806;27559.31101722473;1074.7259448840496;1098.6099934523288;1099.6536091131268;1110.0786347331696;1118.3345909184022;11282.393548933314;11625.332814790298;11651.067914566815;14619.634509137144;15456.99529530577;636259;637347.2530549456;639010;643908;649803;137781;141378;143766;144020.27989859984;144592.27703861624;1157.7047852797482;1217.817327400897;1280.8975281977418;1288.2013151845915;1317.3347459532874;22541.661875072215;22900.770992289865;23237.767622324238;23295.53408931846;23306.184283549996;64156.71686566336;64226.67886660537;65186.67406662936;66043;66357.33642663705;82962.58518707368;82966;83351.5832420834;83530.16469835224;84484;15435.61410964735;15576.688466230838;15703.68592628164;15790.9210453947;15792;24697.62953555662;24983.625245621693;25018.624720628843;25139.24582262535;25204.369890752878;18489.445316640522;19143.138558765168;20063.69904451405;20082.89958550198;20212.595748084663;18151.727724083885;19173;19253.711194332376;19290.4212873614;19521.21915123436;20919.8954005229;21173.78826211718;21209.257675981884;21639.45901352479;21743.565128697654;22761;23119.768802312436;23126.884365578066;23182.188623398775;23191;20038.899805500878;20167.294144704865;20734.481637959172;20864.37406877796;21346 18:04:11 INFO - PID 7760 | |3;mootools.html;1437.1592618318284;1477.926103694815;1507.8039854818865;1511.3501194486366;1524.3978628441762;16284.511464656065;16966.745498817498;16967.406140785075;16968.83031169688;16974.066426346562;16919.238634261455;17342.393016244434;17352.13239338031;17357.566060848487;17360.913195434037;2664.320598247444;2729.0584748261817;2730.754232119109;2730.7678847298002;2731.166994066809;2523.7980961523126;2616.4243866349375;2630.1320564213765;2631.473705258946;2678.1162216468615;2716.6875809281987;2720.1159623122467;2739.739724726148;2741.4791189673897;2743.465024320258;2645.431232285068;2657.176275354637;2662.028359648734;2674.5453272943646;2676.330917270682;2600.752928471792;2606.426586151044;2610.138654244095;2626.7241939596256;2627.710951795301;16461.423850165185;16615.169241537875;16822.411215607517;16847.41034063802;16871.746923796152;8483.66065357385;8762.824743505094;8816.338774591932;8821.206091451735;8829.779255518599;5347.54545863602;5398.757055932492;5463.2078348639625;5509.997051606844;5519.2824932758485;1997.2310660395708;1997.412057414359;2013.395981205647;2033.745781777278;2051.4050925231663;30383.392332153235;30396.54405183924;30733;30735.846320768476;31319.37361252785;7166.713331466683;7277.672504737194;7325.487215894943;7407.518511296748;7466.440016998638;19613;19626.90186549058;19668.70496942547;19684.70472942907;19695.60608787816;8524.914750852537;8638.438501497509;8647.870281945776;8672.95663521691;8689.435186712843;7814.492058016211;7831.099423566249;7912.604369781488;7996.760097197093;8074.636641351153;5424.6473979192015;5651.124075768263;5686.5735069869925;5728.226689396962;5767.279090113736;1538.630728625122;1558.758392449172;1559.337281655292;1562.734335163025;1591.5782317685823;954.9427034377959;973.6689525561202;979.3487330924997;996.5415908681942;1010.5755582655303;8382.622781974826;10065.949670251603;10163.441010744333;10265.230107741949;10354.430506322225;1031.376017509411;1061.1881910338598;1067.066316972649;1076.6434292790982;1088.4938503595865;5713.285839270091;5806.622569532967;5834.457265597699;5837.445442683023;6139.907901381483;24008.27975160748;24768.752312477005;24894.751052489606;25067;25117.74882251154;24782.504349912902;24941.62587561188;25016.249512514652;25099.498010039697;25128;12684.80972785409;12743.553975610808;12826.102172847997;12995.220286782824;13047.543335983195;8730.17063378978;9068.773280668036;9185.402948808307;9206.539673016456;9281.535923203677;21025.789742102384;21230.256941006992;21822.56354872862;21965.67051494261;21985.890070549543;21526;21677.783222167578;21681.783182167976;21933.232336868132;22230.666540002236;12392.690182745504;12466.314352710326;12521.436535355748;12530.122891397516;12541.122121451775;15518;15575.92212038978;15681.294341754876;15718.842811571738;15726.9213653931;12616.179948303698;12656.240625562496;12884.291363974697;12931.094823362275;12995.870041299466;12159.696007599881;12201.877981220074;12274.38628068575;12517.311547864954;12704.745905081661;9230.078115251137;9233.722988310361;9269.67556135532;9349.065093490868;9394.624215031323;7630.847383052419;7761.573113478813;7827.726029588937;7889.84220315579;8001.519908805491;7802.843943121219;7868.567228802471;7889.13219545838;7965.283124518821;7977.08263549676 18:04:11 INFO - PID 7760 | |4;prototype.html;533.0910797090958;555.7832445346313;567.2710566921506;581.0789898011651;582.0803131052937;6751.4936379771525;6769.52613317068;6837.31626837316;6853.314668533157;6880.896786548194;6703.162104736908;6739.966300168505;6756.459483241341;6809.250982391933;6890.483213758976;5547.944520554784;5572.7770889164485;5574.247476590649;5574.275344205248;5580.91628625571;5402.6758394496255;5407.350398304822;5424.5117939385445;5507.311586051744;5523.696196709199;5460.208269800876;5485.232067510552;5494.670319780826;5498.670079795225;5517.393086760453;5503.3120859892515;5529.225908372851;5551.528120109796;5573.637713548606;5580.665160090408;5172.120739474299;5188.8962220755375;5192;5208.166693329049;5225.503577160163;6668.566543174678;6719.025741267537;6766.458683305324;6768.187817461887;6793.558418702769;6379.138816259792;6400.807975760735;6456.160699109086;6554.80335589933;6565.441937435324;7091;7188.931803078817;7248.891266631004;7259.491835571512;7263.65871699019;5672.290963629546;5761.279840019997;5761.740721667493;5763.711814409263;5804.767809287623;7086.18508871476;7251.818704532376;7387.300920788195;7407.222241664602;7562.659680314399;5870.006296788669;5906.202662640574;5938.910916336258;5961.344252132262;5964.747403045322;5971.79098731551;5984.102384642339;6041.009700198342;6051.122587224828;6088.178095957078;6415.871682566322;6471.417572418411;6495.740170393131;6510.18622672166;6517.478601711851;7224.74713385029;7245.637718114073;7270.945712871604;7335.706571737178;7343.192248852622;2104.2219324670937;2115.714378558875;2119.1629306424184;2124.6069477146466;2124.798144176301;1452.1795185720034;1533.463287849244;1546.9767953480707;1571.8506741859505;1573.197669188722;6131.724072416752;6144.723487443076;6159.566971046412;6163.075538669235;6235.532335074888;7054.671958253764;7184.784456466315;7247.492675512769;7269.963650181821;7340.596267205248;6120.234970628671;6122.316363000211;6189.50483961282;6200.224971878515;6207.441330280297;3831.9042023949623;3836.5204349456317;3868.787216703052;3873.8644147455266;3875.8643447479203;7097.716091356391;7113.857722845514;7127.821804454827;7141.214466408691;7147;7490.325870671666;7524.9247507525315;7548.773536793795;7579.924200758032;7584.62076896153;7048.682809273595;7140.357367836816;7163.641817909188;7208.675609597476;7233.168185658506;7330.780076597711;7355.338019578264;7358.448116391399;7375.262473752582;7377.26227377258;7261.419086473175;7294.927050729637;7327.230640782641;7359.484836061424;7379.667914943948;6998.195207551197;7015.859682806417;7085.291470852873;7150.785476435507;7184.461165412719;5972.820815375546;5987.730552125252;5990.6705131218205;5995.310539288038;6008.8798224036145;6924.965375173293;7087.539309944837;7298.306660867209;7300.342969132804;7405;6956.2695916930015;6958.512904096665;6990.825229369307;7038;7070.080889484334;6760.715464061813;6922.480813939075;6955.339242771928;6965.582065076112;7005.964970175117;6839.6580170990255;6862.3823855851215;6879.931200687929;6920.9307906920285;6944.4791640626145;7007.7196912122945;7022.332878376546;7061.6469176542;7077.433805295667;7158.4273258140265;6780.559263647847;6812.591244525344;6882.03651488782;6898.689249042666;6910.654467276516 18:04:11 INFO - PID 7760 | |5;yui.html;945.3382632157492;985.7535616095977;985.9556319965601;1009.8485227215918;1011.6004178349557;18913.810861891376;19368.3221087262;19733.703994440093;19739.605207895835;19742.703859442103;19875.70186447201;19889.900550497263;19927.10328035238;19970.301039463622;20049.799502004975;1063.9734006649837;1084.1868598551087;1087.3095584303944;1088.7006073329858;1090.4166271044992;1040.7398150462384;1110.5835311758092;1112.1492058575197;1112.2103306652286;1113.7271368514685;1161.181367136167;1165.8950694437542;1166.0554950490089;1167.7255844876447;1168.007193885195;1164.9009834164106;1173.2960223865698;1173.325337930689;1173.7828501727208;1177.6055021567786;851.2041241439213;853.0488505316589;853.8377708235478;855.3072011670566;855.9957200214021;19610.215591376327;19934.70097948532;19974.80025199744;20729;21333.146674133015;22627.88686056559;22653.660195097087;22999;23174.304770856903;23302.41743956398;16040.679186416322;16194.676106477922;16363;16385.09881956492;16529.256183471774;4004.599540046001;4037.777922214277;4039.3537034074407;4041.6362527372676;4051.4327994080854;143606.99999999895;143729.2813535936;145053;145261.2736936319;145584;16929.153542322834;17353.2191051403;17412.303507859797;17518;17519.82480175182;27364.726352736616;27613;27679.44641107207;27693;27712.44575108527;9079.909200908038;9296.907030929739;9350.018248083854;9352.438853668802;9373.718788436357;4308.18144552534;4377.562243775661;4389.253826849444;4392.121575684876;4408.228560001987;5857.004309267435;5946.524278057745;6046.818595442144;6072.817815465543;6098.481629061491;1108.4568561405015;1124.8818874018275;1140.3500004997072;1150.4592841364545;1156.4795841871023;739.2533541123397;744.2185705009719;753.1865585168006;768.9384849212049;772.0465225446569;12017.519299227934;12367.876321236852;12590.496380144692;12802.551910683082;12894.67763305925;746.9551826890404;749.2919191364109;750.4671683105057;764.6024067484876;769.7036640893184;5956.702164891824;5969.880602387928;6034.396560344018;6107.328193898667;6167.96916015426;135957;135978;137211;141019.29490352687;142419.2879035619;116524.41737791426;117804.41097794627;118160;120112.39943800225;123113;103001;103326.48336758418;103624.48187759014;104245;104556.47721761343;10814;11184.94407527957;13585.796213056614;14061.859381406464;14154.150750954976;50026.49973500364;50692.23961640652;51125.23312150395;51387.48612513827;52328.47671523388;84864;85529.57235213784;88530.1146988522;88978.55510722405;105003;19491.902540487776;19771.40685779429;19885.502862428555;19894.60210795747;20690.793092068885;22165.113395464;22283.44291392728;22949.655755164018;23142.884285578464;24337.51324973526;20089.698654519903;20110.597788043866;20296.695549566473;20315.59368812645;21281.36155915325;19596.90201548983;19764.209431622574;20250.696239556713;22143.66784498266;22517.437064072874;18845.434636960912;18952.24191032343;19064.523386915436;21952.560948781254;22298.21956231524;14961.401543938557;15058.623534411727;15200.695986079996;15332.8749514215;15830.050196988217;14898.478553250585;15034.774478382615;15638.84361156374;15766.290516926996;15804 18:04:11 INFO - PID 7760 | __end_tp_report 18:04:11 INFO - PID 7760 | __start_cc_report 18:04:11 INFO - PID 7760 | _x_x_mozilla_cycle_collect,333 18:04:11 INFO - PID 7760 | __end_cc_report 18:04:11 INFO - PID 7760 | __startTimestamp1504314251826__endTimestamp 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | ------- Summary: start ------- 18:04:11 INFO - PID 7760 | Number of tests: 6 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | [#0] dojo.html Cycles:165 Average:6836.51 Median:7022.23 stddev:765.19 (10.9%) stddev-sans-first:731.22 18:04:11 INFO - PID 7760 | Values: 3866.8 3920.3 3920.9 3922.7 3941.8 6822.5 6857.3 6870.8 6912.8 6921.8 6669.9 6731.6 6733.1 6736.3 6772.2 6040.9 6054.0 6074.2 6111.1 6189.8 6259.9 6263.4 6275.2 6283.9 6291.9 6096.9 6143.5 6224.8 6235.6 6243.9 5809.8 5953.3 6150.8 6181.1 6217.0 6108.2 6121.8 6196.2 6200.2 6237.7 6805.2 6813.4 6866.2 6908.4 6930.4 7415.4 7432.4 7487.4 7543.7 7554.7 7275.4 7514.4 7521.7 7614.5 7623.0 6817.5 6888.1 6946.3 6948.2 6948.9 7662.3 7688.1 7761.2 7779.3 7810.6 7243.6 7363.2 7383.8 7468.4 7478.5 7262.6 7355.8 7482.9 7550.4 7581.2 7392.4 7438.0 7542.4 7563.4 7567.1 7481.0 7484.2 7490.6 7593.3 7616.9 6147.2 6356.5 6406.2 6487.6 6490.0 5334.1 5357.7 5463.0 5505.0 5576.0 6223.5 6361.3 6373.4 6374.3 6377.9 7439.9 7448.4 7506.3 7531.6 7540.0 6100.4 6180.9 6298.3 6320.0 6362.1 6702.2 6786.8 6799.0 6801.6 6807.8 7110.8 7171.2 7253.9 7272.2 7295.7 7152.3 7203.8 7383.6 7417.8 7495.9 7288.6 7297.9 7314.0 7318.7 7319.4 7352.2 7369.9 7387.1 7406.3 7505.4 7166.1 7297.2 7414.3 7517.4 7540.1 7140.4 7175.9 7185.9 7191.1 7210.9 6998.8 7084.5 7145.3 7183.1 7193.7 6908.8 7022.2 7106.1 7111.4 7210.7 7004.7 7162.6 7274.5 7284.7 7291.0 6895.6 6956.8 6991.9 7003.4 7117.2 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | [#1] ext.html Cycles:180 Average:40738.99 Median:3721.58 stddev:63198.14 (1698.2%) stddev-sans-first:63304.63 18:04:11 INFO - PID 7760 | Values: 900.0 925.8 945.8 977.2 977.5 40899.6 41766.0 41855.6 41884.4 41893.6 38829.4 39024.6 39082.0 39148.0 39229.0 7144.7 7308.7 7317.6 7348.0 7355.4 7217.8 7264.2 7275.5 7300.0 7304.6 7208.5 7854.6 8066.7 8067.7 8076.6 7979.0 8012.5 8046.1 8047.2 8054.7 7685.2 7890.6 7894.2 7917.5 7924.9 38828.4 39118.6 39182.6 39218.8 39544.2 3697.5 3745.7 3747.2 3749.2 3749.4 32307.7 32388.2 32429.4 32464.8 32664.5 5483.4 5493.7 5508.5 5535.3 5537.4 204580.0 206321.0 206802.0 209089.0 243681.0 48453.3 49194.8 49262.8 49343.5 49366.3 52118.7 52355.5 52372.0 52463.0 52505.7 14400.6 14478.6 14498.8 14504.6 14512.0 11451.7 11474.5 11478.2 11580.1 11586.3 14194.1 14198.9 14257.2 14274.1 14284.9 5652.1 5680.9 5712.3 5756.7 5770.8 1070.4 1078.6 1093.3 1098.6 1113.8 22939.4 23026.9 23075.7 23144.2 23665.0 1178.9 1179.6 1186.6 1189.5 1190.5 12558.0 12786.6 12877.2 12948.0 12976.2 279782.0 280448.0 282215.0 282324.0 282373.0 52980.5 53382.0 53724.7 53730.7 53956.5 1446.5 1479.8 1489.5 1508.9 1513.3 21628.5 21674.0 21728.7 22364.2 22806.3 39480.2 39610.8 39661.6 39696.8 39743.6 226146.0 226363.0 226518.0 227050.0 227504.0 34094.1 34735.7 35164.0 35344.8 35404.0 43574.6 44179.0 44201.1 44315.8 44584.3 32870.8 33071.8 33359.0 33529.5 33661.3 32775.7 33387.7 33434.8 33520.8 33781.0 38180.2 38251.2 38268.8 38645.8 38663.0 32055.7 32363.0 32368.0 32384.5 32487.5 24089.5 24373.5 24443.6 24740.3 25056.0 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | [#2] jquery.html Cycles:180 Average:42129.64 Median:23870.02 stddev:107478.87 (450.3%) stddev-sans-first:107735.10 18:04:11 INFO - PID 7760 | Values: 577.2 579.6 590.5 596.0 603.4 22900.3 23323.0 23862.8 23877.3 23899.8 24209.2 24497.9 24688.9 24738.5 24746.3 6844.8 7007.5 7011.8 7014.8 7020.9 6425.7 6779.7 6786.5 6787.0 6792.1 6721.6 6749.3 6762.0 6768.0 6768.5 6738.0 6751.4 6754.3 6756.0 6759.3 6270.8 6294.4 6297.2 6298.2 6304.9 28868.6 30586.0 30918.7 31098.8 31103.0 2277.8 2304.2 2307.2 2308.7 2313.3 19895.7 20704.3 20711.6 20746.5 20749.3 2489.5 2491.6 2546.1 2576.1 2582.1 155994.0 163415.0 163605.0 164123.0 164148.0 16314.3 16482.2 16522.3 16749.1 16979.2 25808.5 25811.7 25825.9 25834.1 25842.4 9876.4 10056.3 10193.6 10227.0 10229.8 9106.6 9119.0 9125.6 9187.9 9202.8 9870.2 9876.9 10080.4 10117.6 10265.5 2938.6 2966.5 3001.7 3014.0 3083.2 1017.9 1023.2 1039.6 1040.8 1046.6 19875.8 25741.2 27123.1 27386.0 27559.3 1074.7 1098.6 1099.7 1110.1 1118.3 11282.4 11625.3 11651.1 14619.6 15457.0 636259.0 637347.3 639010.0 643908.0 649803.0 137781.0 141378.0 143766.0 144020.3 144592.3 1157.7 1217.8 1280.9 1288.2 1317.3 22541.7 22900.8 23237.8 23295.5 23306.2 64156.7 64226.7 65186.7 66043.0 66357.3 82962.6 82966.0 83351.6 83530.2 84484.0 15435.6 15576.7 15703.7 15790.9 15792.0 24697.6 24983.6 25018.6 25139.2 25204.4 18489.4 19143.1 20063.7 20082.9 20212.6 18151.7 19173.0 19253.7 19290.4 19521.2 20919.9 21173.8 21209.3 21639.5 21743.6 22761.0 23119.8 23126.9 23182.2 23191.0 20038.9 20167.3 20734.5 20864.4 21346.0 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | [#3] mootools.html Cycles:180 Average:10404.93 Median:2562.28 stddev:7765.41 (303.1%) stddev-sans-first:7757.96 18:04:11 INFO - PID 7760 | Values: 1437.2 1477.9 1507.8 1511.4 1524.4 16284.5 16966.7 16967.4 16968.8 16974.1 16919.2 17342.4 17352.1 17357.6 17360.9 2664.3 2729.1 2730.8 2730.8 2731.2 2523.8 2616.4 2630.1 2631.5 2678.1 2716.7 2720.1 2739.7 2741.5 2743.5 2645.4 2657.2 2662.0 2674.5 2676.3 2600.8 2606.4 2610.1 2626.7 2627.7 16461.4 16615.2 16822.4 16847.4 16871.7 8483.7 8762.8 8816.3 8821.2 8829.8 5347.5 5398.8 5463.2 5510.0 5519.3 1997.2 1997.4 2013.4 2033.7 2051.4 30383.4 30396.5 30733.0 30735.8 31319.4 7166.7 7277.7 7325.5 7407.5 7466.4 19613.0 19626.9 19668.7 19684.7 19695.6 8524.9 8638.4 8647.9 8673.0 8689.4 7814.5 7831.1 7912.6 7996.8 8074.6 5424.6 5651.1 5686.6 5728.2 5767.3 1538.6 1558.8 1559.3 1562.7 1591.6 954.9 973.7 979.3 996.5 1010.6 8382.6 10065.9 10163.4 10265.2 10354.4 1031.4 1061.2 1067.1 1076.6 1088.5 5713.3 5806.6 5834.5 5837.4 6139.9 24008.3 24768.8 24894.8 25067.0 25117.7 24782.5 24941.6 25016.2 25099.5 25128.0 12684.8 12743.6 12826.1 12995.2 13047.5 8730.2 9068.8 9185.4 9206.5 9281.5 21025.8 21230.3 21822.6 21965.7 21985.9 21526.0 21677.8 21681.8 21933.2 22230.7 12392.7 12466.3 12521.4 12530.1 12541.1 15518.0 15575.9 15681.3 15718.8 15726.9 12616.2 12656.2 12884.3 12931.1 12995.9 12159.7 12201.9 12274.4 12517.3 12704.7 9230.1 9233.7 9269.7 9349.1 9394.6 7630.8 7761.6 7827.7 7889.8 8001.5 7802.8 7868.6 7889.1 7965.3 7977.1 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | [#4] prototype.html Cycles:180 Average:6090.47 Median:6758.59 stddev:1630.06 (24.1%) stddev-sans-first:1580.36 18:04:11 INFO - PID 7760 | Values: 533.1 555.8 567.3 581.1 582.1 6751.5 6769.5 6837.3 6853.3 6880.9 6703.2 6740.0 6756.5 6809.3 6890.5 5547.9 5572.8 5574.2 5574.3 5580.9 5402.7 5407.4 5424.5 5507.3 5523.7 5460.2 5485.2 5494.7 5498.7 5517.4 5503.3 5529.2 5551.5 5573.6 5580.7 5172.1 5188.9 5192.0 5208.2 5225.5 6668.6 6719.0 6766.5 6768.2 6793.6 6379.1 6400.8 6456.2 6554.8 6565.4 7091.0 7188.9 7248.9 7259.5 7263.7 5672.3 5761.3 5761.7 5763.7 5804.8 7086.2 7251.8 7387.3 7407.2 7562.7 5870.0 5906.2 5938.9 5961.3 5964.7 5971.8 5984.1 6041.0 6051.1 6088.2 6415.9 6471.4 6495.7 6510.2 6517.5 7224.7 7245.6 7270.9 7335.7 7343.2 2104.2 2115.7 2119.2 2124.6 2124.8 1452.2 1533.5 1547.0 1571.9 1573.2 6131.7 6144.7 6159.6 6163.1 6235.5 7054.7 7184.8 7247.5 7270.0 7340.6 6120.2 6122.3 6189.5 6200.2 6207.4 3831.9 3836.5 3868.8 3873.9 3875.9 7097.7 7113.9 7127.8 7141.2 7147.0 7490.3 7524.9 7548.8 7579.9 7584.6 7048.7 7140.4 7163.6 7208.7 7233.2 7330.8 7355.3 7358.4 7375.3 7377.3 7261.4 7294.9 7327.2 7359.5 7379.7 6998.2 7015.9 7085.3 7150.8 7184.5 5972.8 5987.7 5990.7 5995.3 6008.9 6925.0 7087.5 7298.3 7300.3 7405.0 6956.3 6958.5 6990.8 7038.0 7070.1 6760.7 6922.5 6955.3 6965.6 7006.0 6839.7 6862.4 6879.9 6920.9 6944.5 7007.7 7022.3 7061.6 7077.4 7158.4 6780.6 6812.6 6882.0 6898.7 6910.7 18:04:11 INFO - PID 7760 | 18:04:11 INFO - PID 7760 | [#5] yui.html Cycles:180 Average:27525.04 Median:19823.55 stddev:39166.06 (197.6%) stddev-sans-first:39225.08 18:04:11 INFO - PID 7760 | Values: 945.3 985.8 986.0 1009.8 1011.6 18913.8 19368.3 19733.7 19739.6 19742.7 19875.7 19889.9 19927.1 19970.3 20049.8 1064.0 1084.2 1087.3 1088.7 1090.4 1040.7 1110.6 1112.1 1112.2 1113.7 1161.2 1165.9 1166.1 1167.7 1168.0 1164.9 1173.3 1173.3 1173.8 1177.6 851.2 853.0 853.8 855.3 856.0 19610.2 19934.7 19974.8 20729.0 21333.1 22627.9 22653.7 22999.0 23174.3 23302.4 16040.7 16194.7 16363.0 16385.1 16529.3 4004.6 4037.8 4039.4 4041.6 4051.4 143607.0 143729.3 145053.0 145261.3 145584.0 16929.2 17353.2 17412.3 17518.0 17519.8 27364.7 27613.0 27679.4 27693.0 27712.4 9079.9 9296.9 9350.0 9352.4 9373.7 4308.2 4377.6 4389.3 4392.1 4408.2 5857.0 5946.5 6046.8 6072.8 6098.5 1108.5 1124.9 1140.4 1150.5 1156.5 739.3 744.2 753.2 768.9 772.0 12017.5 12367.9 12590.5 12802.6 12894.7 747.0 749.3 750.5 764.6 769.7 5956.7 5969.9 6034.4 6107.3 6168.0 135957.0 135978.0 137211.0 141019.3 142419.3 116524.4 117804.4 118160.0 120112.4 123113.0 103001.0 103326.5 103624.5 104245.0 104556.5 10814.0 11184.9 13585.8 14061.9 14154.2 50026.5 50692.2 51125.2 51387.5 52328.5 84864.0 85529.6 88530.1 88978.6 105003.0 19491.9 19771.4 19885.5 19894.6 20690.8 22165.1 22283.4 22949.7 23142.9 24337.5 20089.7 20110.6 20296.7 20315.6 21281.4 19596.9 19764.2 20250.7 22143.7 22517.4 18845.4 18952.2 19064.5 21952.6 22298.2 14961.4 15058.6 15200.7 15332.9 15830.1 14898.5 15034.8 15638.8 15766.3 15804.0 18:04:11 INFO - PID 7760 | -------- Summary: end -------- 18:04:11 INFO - PID 7760 | 18:04:12 INFO - TEST-INFO | 7760: exit 0 18:04:12 INFO - TEST-OK | dromaeo_css | took 1109144ms 18:04:12 INFO - TEST-START | kraken 18:04:12 INFO - Initialising browser for kraken test... 18:04:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58739/getInfo.html -profile /tmp/tmp0xKQc2/profile 18:04:12 INFO - TEST-INFO | started process 8132 (/builds/slave/test/build/application/firefox/firefox http://localhost:58739/getInfo.html) 18:04:17 INFO - TEST-INFO | 8132: exit 0 18:04:18 INFO - Browser initialized. 18:04:18 INFO - Running cycle 1/1 for kraken test... 18:04:18 INFO - Using env: {'DISPLAY': ':0', 18:04:18 INFO - 'HOME': '/home/cltbld', 18:04:18 INFO - 'JSGC_DISABLE_POISONING': '1', 18:04:18 INFO - 'LANG': 'en_US.UTF-8', 18:04:18 INFO - 'LANGUAGE': 'en_US:en', 18:04:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:04:18 INFO - 'LOGNAME': 'cltbld', 18:04:18 INFO - 'MAIL': '/var/mail/cltbld', 18:04:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:04:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:04:18 INFO - 'MOZ_CRASHREPORTER': '1', 18:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:04:18 INFO - 'MOZ_NO_REMOTE': '1', 18:04:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:18 INFO - 'NO_EM_RESTART': '1', 18:04:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:18 INFO - 'PWD': '/builds/slave/test', 18:04:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:04:18 INFO - 'RUST_BACKTRACE': 'full', 18:04:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:04:18 INFO - 'SHELL': '/bin/bash', 18:04:18 INFO - 'SHLVL': '1', 18:04:18 INFO - 'TERM': 'linux', 18:04:18 INFO - 'TMOUT': '86400', 18:04:18 INFO - 'USER': 'cltbld', 18:04:18 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928', 18:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:18 INFO - '_': '/tools/buildbot/bin/python'} 18:04:18 INFO - TEST-INFO | started process 8321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0xKQc2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:18 INFO - PID 8321 | 18:04:18 INFO - PID 8321 | (/builds/slave/test/build/application/firefox/firefox:8373): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:04:18 INFO - PID 8321 | 18:04:29 INFO - PID 8321 | RSS: Main: 161492992 18:04:29 INFO - PID 8321 | 18:04:31 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58739/tests/kraken/driver.html?testName=audio-beat-detection) 18:04:32 INFO - PID 8321 | RSS: Main: 165908480 18:04:32 INFO - PID 8321 | 18:04:35 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58739/tests/kraken/driver.html?testName=audio-dft) 18:04:35 INFO - PID 8321 | RSS: Main: 170663936 18:04:35 INFO - PID 8321 | 18:04:38 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58739/tests/kraken/driver.html?testName=audio-fft) 18:04:39 INFO - PID 8321 | RSS: Main: 163749888 18:04:39 INFO - PID 8321 | 18:04:41 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58739/tests/kraken/driver.html?testName=audio-oscillator) 18:04:42 INFO - PID 8321 | RSS: Main: 164839424 18:04:42 INFO - PID 8321 | 18:04:44 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:44 INFO - PID 8321 | RSS: Main: 164790272 18:04:44 INFO - PID 8321 | 18:04:47 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58739/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:48 INFO - PID 8321 | RSS: Main: 165003264 18:04:48 INFO - PID 8321 | 18:04:51 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58739/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:52 INFO - PID 8321 | RSS: Main: 166109184 18:04:52 INFO - PID 8321 | 18:04:55 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58739/tests/kraken/driver.html?testName=json-parse-financial) 18:04:55 INFO - PID 8321 | RSS: Main: 166252544 18:04:55 INFO - PID 8321 | 18:04:57 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:57 INFO - PID 8321 | RSS: Main: 166146048 18:04:57 INFO - PID 8321 | 18:04:59 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:05:00 INFO - PID 8321 | RSS: Main: 165879808 18:05:00 INFO - PID 8321 | 18:05:02 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:05:02 INFO - PID 8321 | RSS: Main: 163028992 18:05:02 INFO - PID 8321 | 18:05:05 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:05:05 INFO - PID 8321 | RSS: Main: 162988032 18:05:05 INFO - PID 8321 | 18:05:08 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:05:09 INFO - PID 8321 | RSS: Main: 163332096 18:05:09 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | Cycle 1(1): loaded http://localhost:58739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58739/tests/kraken/driver.html?testName=ai-astar) 18:05:11 INFO - PID 8321 | RSS: Main: 165253120 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | __start_tp_report 18:05:11 INFO - PID 8321 | _x_x_mozilla_page_load 18:05:11 INFO - PID 8321 | _x_x_mozilla_page_load_details 18:05:11 INFO - PID 8321 | |i|pagename|runs| 18:05:11 INFO - PID 8321 | |0;ai-astar;99;107;94;106;104;106;110;108;106;110 18:05:11 INFO - PID 8321 | |1;audio-beat-detection;140;110;134;162;112;152;139;119;170;113 18:05:11 INFO - PID 8321 | |2;audio-dft;163;162;160;162;171;163;165;165;165;166 18:05:11 INFO - PID 8321 | |3;audio-fft;74;73;74;170;77;73;73;87;98;74 18:05:11 INFO - PID 8321 | |4;audio-oscillator;78;78;135;78;78;78;134;78;78;126 18:05:11 INFO - PID 8321 | |5;imaging-gaussian-blur;114;114;114;114;115;114;114;114;114;114 18:05:11 INFO - PID 8321 | |6;imaging-darkroom;151;150;157;150;149;150;150;151;149;150 18:05:11 INFO - PID 8321 | |7;imaging-desaturate;102;94;94;95;95;95;94;94;94;95 18:05:11 INFO - PID 8321 | |8;json-parse-financial;44;43;43;43;44;43;44;44;43;46 18:05:11 INFO - PID 8321 | |9;json-stringify-tinderbox;36;36;35;36;35;36;35;35;36;37 18:05:11 INFO - PID 8321 | |10;stanford-crypto-aes;77;72;74;75;74;79;73;73;74;77 18:05:11 INFO - PID 8321 | |11;stanford-crypto-ccm;114;110;115;114;111;109;111;116;109;152 18:05:11 INFO - PID 8321 | |12;stanford-crypto-pbkdf2;158;161;169;153;157;158;153;152;164;163 18:05:11 INFO - PID 8321 | |13;stanford-crypto-sha256-iterative;62;65;60;60;60;58;60;62;61;59 18:05:11 INFO - PID 8321 | __end_tp_report 18:05:11 INFO - PID 8321 | __start_cc_report 18:05:11 INFO - PID 8321 | _x_x_mozilla_cycle_collect,903 18:05:11 INFO - PID 8321 | __end_cc_report 18:05:11 INFO - PID 8321 | __startTimestamp1504314311255__endTimestamp 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | ------- Summary: start ------- 18:05:11 INFO - PID 8321 | Number of tests: 14 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#0] ai-astar Cycles:10 Average:105.00 Median:109.00 stddev:4.99 (4.6%) stddev-sans-first:4.80 18:05:11 INFO - PID 8321 | Values: 99.0 107.0 94.0 106.0 104.0 106.0 110.0 108.0 106.0 110.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:139.50 stddev:21.55 (15.4%) stddev-sans-first:22.78 18:05:11 INFO - PID 8321 | Values: 140.0 110.0 134.0 162.0 112.0 152.0 139.0 119.0 170.0 113.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:3.01 (1.8%) stddev-sans-first:3.16 18:05:11 INFO - PID 8321 | Values: 163.0 162.0 160.0 162.0 171.0 163.0 165.0 165.0 165.0 166.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#3] audio-fft Cycles:10 Average:87.30 Median:74.00 stddev:30.19 (40.8%) stddev-sans-first:31.64 18:05:11 INFO - PID 8321 | Values: 74.0 73.0 74.0 170.0 77.0 73.0 73.0 87.0 98.0 74.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.00 stddev:26.03 (33.4%) stddev-sans-first:26.95 18:05:11 INFO - PID 8321 | Values: 78.0 78.0 135.0 78.0 78.0 78.0 134.0 78.0 78.0 126.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 18:05:11 INFO - PID 8321 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:150.00 stddev:2.31 (1.5%) stddev-sans-first:2.45 18:05:11 INFO - PID 8321 | Values: 151.0 150.0 157.0 150.0 149.0 150.0 150.0 151.0 149.0 150.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.50 stddev:2.44 (2.6%) stddev-sans-first:0.53 18:05:11 INFO - PID 8321 | Values: 102.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:44.00 stddev:0.95 (2.2%) stddev-sans-first:1.00 18:05:11 INFO - PID 8321 | Values: 44.0 43.0 43.0 43.0 44.0 43.0 44.0 44.0 43.0 46.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#9] json-stringify-tinderbox Cycles:10 Average:35.70 Median:36.00 stddev:0.67 (1.9%) stddev-sans-first:0.71 18:05:11 INFO - PID 8321 | Values: 36.0 36.0 35.0 36.0 35.0 36.0 35.0 35.0 36.0 37.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.50 stddev:2.20 (3.0%) stddev-sans-first:2.19 18:05:11 INFO - PID 8321 | Values: 77.0 72.0 74.0 75.0 74.0 79.0 73.0 73.0 74.0 77.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:114.00 stddev:12.86 (11.3%) stddev-sans-first:13.62 18:05:11 INFO - PID 8321 | Values: 114.0 110.0 115.0 114.0 111.0 109.0 111.0 116.0 109.0 152.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.80 Median:159.50 stddev:5.49 (3.4%) stddev-sans-first:5.82 18:05:11 INFO - PID 8321 | Values: 158.0 161.0 169.0 153.0 157.0 158.0 153.0 152.0 164.0 163.0 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:60.50 stddev:1.95 (3.2%) stddev-sans-first:2.01 18:05:11 INFO - PID 8321 | Values: 62.0 65.0 60.0 60.0 60.0 58.0 60.0 62.0 61.0 59.0 18:05:11 INFO - PID 8321 | -------- Summary: end -------- 18:05:11 INFO - PID 8321 | 18:05:11 INFO - PID 8321 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:05:11 INFO - TEST-INFO | 8321: exit 0 18:05:11 INFO - TEST-OK | kraken | took 59471ms 18:05:11 INFO - SUITE-END | took 1168s 18:05:12 INFO - Completed test suite (00:19:29) 18:05:12 INFO - javascript benchmark 18:05:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9309.222765009094, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3866.8259928303205, 3920.3139450596145, 3920.882373528794, 3922.705797065217, 3941.8029098545085, 6822.522423430361, 6857.279985601514, 6870.82822929427, 6912.792616221515, 6921.7577384791475, 6669.866602667944, 6731.56244844086, 6733.091032710583, 6736.326367363261, 6772.221194562627, 6040.909386359186, 6053.969730151354, 6074.179985701918, 6111.144439778434, 6189.81430557084, 6259.874802503947, 6263.373662633723, 6275.215598050244, 6283.874322513547, 6291.937080629181, 6096.908546371808, 6143.508519318444, 6224.813255602339, 6235.594686345373, 6243.906341404882, 5809.7676092956235, 5953.28560572734, 6150.753969841201, 6181.07283907413, 6217.0, 6108.236470441195, 6121.816345509642, 6196.163517925068, 6200.224971878515, 6237.656928868911, 6805.217399999014, 6813.420859226922, 6866.244713081557, 6908.378245957838, 6930.3762661360215, 7415.406767458644, 7432.405407567381, 7487.438442116863, 7543.73596924105, 7554.69781208751, 7275.381592564639, 7514.4364172687265, 7521.661525231378, 7614.543127412373, 7623.009008828817, 6817.488688348394, 6888.104546408985, 6946.340097690711, 6948.200956889972, 6948.895766563505, 7662.272084151997, 7688.077430708351, 7761.223877612307, 7779.260970207822, 7810.570418626917, 7243.601601911945, 7363.190049094595, 7383.8154046149275, 7468.439867009996, 7478.476506644592, 7262.5642461451425, 7355.816104597321, 7482.925170748332, 7550.433717471212, 7581.203973582805, 7392.44556658242, 7438.0, 7542.358899493604, 7563.432742544332, 7567.091948966159, 7480.990066341084, 7484.214157513492, 7490.550566966, 7593.316601505891, 7616.9238307616215, 6147.200863887666, 6356.45970092538, 6406.199225096863, 6487.578307410097, 6489.967550162219, 5334.11987022137, 5357.651752636066, 5463.043967305705, 5504.972475137599, 5575.972120139373, 6223.502119830403, 6361.332060133619, 6373.3945275198785, 6374.298827129012, 6377.904331435032, 7439.851202976019, 7448.4041276697735, 7506.3244308012545, 7531.585762783099, 7540.0, 6100.420460056376, 6180.938190618036, 6298.307186209513, 6320.0, 6362.141110950055, 6702.229243637044, 6786.796396108125, 6799.048133261347, 6801.591904485746, 6807.829804254933, 7110.822229444202, 7171.211166771755, 7253.8549229015125, 7272.163701174432, 7295.744648937261, 7152.284771522806, 7203.819904502429, 7383.556986580822, 7417.777466676009, 7495.88756168647, 7288.562686238843, 7297.890531641923, 7314.012608297811, 7318.707251709872, 7319.4144468443465, 7352.191258961617, 7369.89259080527, 7387.076615423072, 7406.333429991327, 7505.362044226302, 7166.1400631922415, 7297.160826504807, 7414.295641914009, 7517.361024312776, 7540.0951885771865, 7140.357367836919, 7175.928240717735, 7185.856282874418, 7191.065161528968, 7210.89183662235, 6998.825029374307, 7084.504084714226, 7145.321194486515, 7183.066201393785, 7193.71225151009, 6908.827279317856, 7022.227554969051, 7106.076210092655, 7111.359977602041, 7210.675519601736, 7004.684789184601, 7162.641867906688, 7274.454415918933, 7284.67218975158, 7290.9635451822405, 6895.55178913369, 6956.826079348057, 6991.916252980796, 7003.4397248219, 7117.217106118426], "value": 6786.089910203558, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.9640014399422, 925.7639301977995, 945.8155659646369, 977.208461146471, 977.5356705564853, 40899.59100408995, 41765.95585110374, 41855.58144418555, 41884.37173442401, 41893.58106418935, 38829.41755873657, 39024.609753902456, 39082.0, 39148.0, 39229.0, 7144.749933752332, 7308.707651693926, 7317.5609463432365, 7348.0, 7355.37479314259, 7217.819554511153, 7264.164621068566, 7275.490715649907, 7299.963500182518, 7304.561726296412, 7208.49540532163, 7854.646540905673, 8066.71766488173, 8067.677292908306, 8076.555789431579, 7978.960105199466, 8012.5192488450875, 8046.114927357986, 8047.195280471965, 8054.7180848670305, 7685.23147685227, 7890.605469726548, 7894.171112033268, 7917.524948503108, 7924.881126783045, 38828.41757373614, 39118.60881391178, 39182.60817391818, 39218.803905980574, 39544.20911581781, 3697.5008373869723, 3745.662890339855, 3747.194353214045, 3749.1939233065023, 3749.4000959846294, 32307.676923230938, 32388.190295242573, 32429.35141297161, 32464.837675811705, 32664.510032349535, 5483.396826349099, 5493.725313734337, 5508.476694713996, 5535.25274087997, 5537.418571050022, 204580.0, 206321.0, 206802.0, 209089.0, 243681.0, 48453.27320090131, 49194.75402623036, 49262.753686232056, 49343.50656493461, 49366.25950610744, 52118.739406302724, 52355.47644523582, 52372.0, 52463.0, 52505.7374713124, 14400.567982960529, 14478.638034049232, 14498.782518262235, 14504.637384065272, 14512.0, 11451.713707157387, 11474.54101835934, 11478.19652624325, 11580.073594112619, 11586.304821710724, 14194.077384969944, 14198.85801141996, 14257.215853128178, 14274.14355138695, 14284.928575357264, 5652.123920792284, 5680.857978550569, 5712.343080545707, 5756.65460072397, 5770.816982518658, 1070.4380200394855, 1078.5739632844982, 1093.3221402730358, 1098.5825386353135, 1113.821788513834, 22939.37507780406, 23026.884865575565, 23075.653865192035, 23144.189953351553, 23665.0, 1178.8762179971152, 1179.622520793355, 1186.6202815099086, 1189.547971770739, 1190.4999900042003, 12558.0, 12786.61640150797, 12877.162984405984, 12948.0, 12976.221426714428, 279782.0, 280448.0, 282215.0, 282324.0, 282373.0, 52980.47019529832, 53382.0, 53724.73137634287, 53730.73134634302, 53956.46043539593, 1446.522647526314, 1479.8446163152714, 1489.4637930345068, 1508.9170095644845, 1513.311443293299, 21628.45928851791, 21674.0, 21728.67406988865, 22364.217252396087, 22806.31581052571, 39480.2103957925, 39610.80194599008, 39661.60338396579, 39696.80151599339, 39743.60256397399, 226146.0, 226363.0, 226518.0, 227050.0, 227504.0, 34094.147646309044, 34735.652643473244, 35164.0, 35344.82327588346, 35404.0, 43574.56425435705, 44179.0, 44201.11597767963, 44315.77842110769, 44584.331235030855, 32870.835645821615, 33071.834640826644, 33359.0, 33529.49705754464, 33661.32677346488, 32775.67224327726, 33387.666123339426, 33434.832825835714, 33520.83239583787, 33781.0, 38180.23639527249, 38251.2349753009, 38268.80865595654, 38645.80677096709, 38663.0, 32055.67944320527, 32363.0, 32368.0, 32384.514232286063, 32487.512687309238, 24089.51820963606, 24373.51252974966, 24443.633345500188, 24740.25779226626, 25056.0], "value": 17613.73313264118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2207519848203, 579.5827004556718, 590.5216774412726, 595.961262517936, 603.4086595136765, 22900.312990610266, 23323.0, 23862.76137238627, 23877.28368148956, 23899.761002389972, 24209.152679656214, 24497.877510612467, 24688.87655561724, 24738.505229895392, 24746.25761227166, 6844.82887927802, 7007.544509606859, 7011.789646310619, 7014.824629384255, 7020.894686579705, 6425.678716064202, 6779.728810847585, 6786.491013174007, 6787.0, 6792.0830687857, 6721.596704197739, 6749.2913244109395, 6762.019507171482, 6768.018637297589, 6768.492363072764, 6738.0, 6751.358620931003, 6754.2907994660345, 6755.966220168917, 6759.256481787, 6270.811875643738, 6294.370562943669, 6297.244330680348, 6298.2442106947, 6304.905426418607, 28868.566971495446, 30586.0, 30918.69081309203, 31098.844505777328, 31103.0, 2277.794998450131, 2304.20504925802, 2307.157887371114, 2308.7114110736156, 2313.3291345509783, 19895.701564476545, 20704.275350362666, 20711.58576828455, 20746.48133796652, 20749.273775417787, 2489.514544663791, 2491.6262560615874, 2546.121588052119, 2576.0726138590094, 2582.14789119592, 155994.0, 163415.0, 163605.0, 164123.0, 164148.0, 16314.26585803618, 16482.175891205392, 16522.339106435607, 16749.07880066608, 16979.23593438298, 25808.48383032329, 25811.741882580933, 25825.870870645904, 25834.095806647052, 25842.35394115162, 9876.40741555509, 10056.34633748804, 10193.592256309665, 10227.0, 10229.846552301722, 9106.635734570675, 9118.954405228063, 9125.589348479334, 9187.908120918706, 9202.769930751785, 9870.21038316933, 9876.888780034265, 10080.445575493419, 10117.645882394081, 10265.486725663686, 2938.617979662673, 2966.5401862711315, 3001.654809696869, 3013.984930075336, 3083.2291927018246, 1017.8880323164447, 1023.2070145637191, 1039.616049758048, 1040.8230600797883, 1046.6441409920512, 19875.801241987396, 25741.22776316676, 27123.050693226036, 27386.041488547806, 27559.31101722473, 1074.7259448840496, 1098.6099934523288, 1099.6536091131268, 1110.0786347331696, 1118.3345909184022, 11282.393548933314, 11625.332814790298, 11651.067914566815, 14619.634509137144, 15456.99529530577, 636259.0, 637347.2530549456, 639010.0, 643908.0, 649803.0, 137781.0, 141378.0, 143766.0, 144020.27989859984, 144592.27703861624, 1157.7047852797482, 1217.817327400897, 1280.8975281977418, 1288.2013151845915, 1317.3347459532874, 22541.661875072215, 22900.770992289865, 23237.767622324238, 23295.53408931846, 23306.184283549996, 64156.71686566336, 64226.67886660537, 65186.67406662936, 66043.0, 66357.33642663705, 82962.58518707368, 82966.0, 83351.5832420834, 83530.16469835224, 84484.0, 15435.61410964735, 15576.688466230838, 15703.68592628164, 15790.9210453947, 15792.0, 24697.62953555662, 24983.625245621693, 25018.624720628843, 25139.24582262535, 25204.369890752878, 18489.445316640522, 19143.138558765168, 20063.69904451405, 20082.89958550198, 20212.595748084663, 18151.727724083885, 19173.0, 19253.711194332376, 19290.4212873614, 19521.21915123436, 20919.8954005229, 21173.78826211718, 21209.257675981884, 21639.45901352479, 21743.565128697654, 22761.0, 23119.768802312436, 23126.884365578066, 23182.188623398775, 23191.0, 20038.899805500878, 20167.294144704865, 20734.481637959172, 20864.37406877796, 21346.0], "value": 13266.772025530892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.1592618318284, 1477.926103694815, 1507.8039854818865, 1511.3501194486366, 1524.3978628441762, 16284.511464656065, 16966.745498817498, 16967.406140785075, 16968.83031169688, 16974.066426346562, 16919.238634261455, 17342.393016244434, 17352.13239338031, 17357.566060848487, 17360.913195434037, 2664.320598247444, 2729.0584748261817, 2730.754232119109, 2730.7678847298002, 2731.166994066809, 2523.7980961523126, 2616.4243866349375, 2630.1320564213765, 2631.473705258946, 2678.1162216468615, 2716.6875809281987, 2720.1159623122467, 2739.739724726148, 2741.4791189673897, 2743.465024320258, 2645.431232285068, 2657.176275354637, 2662.028359648734, 2674.5453272943646, 2676.330917270682, 2600.752928471792, 2606.426586151044, 2610.138654244095, 2626.7241939596256, 2627.710951795301, 16461.423850165185, 16615.169241537875, 16822.411215607517, 16847.41034063802, 16871.746923796152, 8483.66065357385, 8762.824743505094, 8816.338774591932, 8821.206091451735, 8829.779255518599, 5347.54545863602, 5398.757055932492, 5463.2078348639625, 5509.997051606844, 5519.2824932758485, 1997.2310660395708, 1997.412057414359, 2013.395981205647, 2033.745781777278, 2051.4050925231663, 30383.392332153235, 30396.54405183924, 30733.0, 30735.846320768476, 31319.37361252785, 7166.713331466683, 7277.672504737194, 7325.487215894943, 7407.518511296748, 7466.440016998638, 19613.0, 19626.90186549058, 19668.70496942547, 19684.70472942907, 19695.60608787816, 8524.914750852537, 8638.438501497509, 8647.870281945776, 8672.95663521691, 8689.435186712843, 7814.492058016211, 7831.099423566249, 7912.604369781488, 7996.760097197093, 8074.636641351153, 5424.6473979192015, 5651.124075768263, 5686.5735069869925, 5728.226689396962, 5767.279090113736, 1538.630728625122, 1558.758392449172, 1559.337281655292, 1562.734335163025, 1591.5782317685823, 954.9427034377959, 973.6689525561202, 979.3487330924997, 996.5415908681942, 1010.5755582655303, 8382.622781974826, 10065.949670251603, 10163.441010744333, 10265.230107741949, 10354.430506322225, 1031.376017509411, 1061.1881910338598, 1067.066316972649, 1076.6434292790982, 1088.4938503595865, 5713.285839270091, 5806.622569532967, 5834.457265597699, 5837.445442683023, 6139.907901381483, 24008.27975160748, 24768.752312477005, 24894.751052489606, 25067.0, 25117.74882251154, 24782.504349912902, 24941.62587561188, 25016.249512514652, 25099.498010039697, 25128.0, 12684.80972785409, 12743.553975610808, 12826.102172847997, 12995.220286782824, 13047.543335983195, 8730.17063378978, 9068.773280668036, 9185.402948808307, 9206.539673016456, 9281.535923203677, 21025.789742102384, 21230.256941006992, 21822.56354872862, 21965.67051494261, 21985.890070549543, 21526.0, 21677.783222167578, 21681.783182167976, 21933.232336868132, 22230.666540002236, 12392.690182745504, 12466.314352710326, 12521.436535355748, 12530.122891397516, 12541.122121451775, 15518.0, 15575.92212038978, 15681.294341754876, 15718.842811571738, 15726.9213653931, 12616.179948303698, 12656.240625562496, 12884.291363974697, 12931.094823362275, 12995.870041299466, 12159.696007599881, 12201.877981220074, 12274.38628068575, 12517.311547864954, 12704.745905081661, 9230.078115251137, 9233.722988310361, 9269.67556135532, 9349.065093490868, 9394.624215031323, 7630.847383052419, 7761.573113478813, 7827.726029588937, 7889.84220315579, 8001.519908805491, 7802.843943121219, 7868.567228802471, 7889.13219545838, 7965.283124518821, 7977.08263549676], "value": 7247.930294266924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.0910797090958, 555.7832445346313, 567.2710566921506, 581.0789898011651, 582.0803131052937, 6751.4936379771525, 6769.52613317068, 6837.31626837316, 6853.314668533157, 6880.896786548194, 6703.162104736908, 6739.966300168505, 6756.459483241341, 6809.250982391933, 6890.483213758976, 5547.944520554784, 5572.7770889164485, 5574.247476590649, 5574.275344205248, 5580.91628625571, 5402.6758394496255, 5407.350398304822, 5424.5117939385445, 5507.311586051744, 5523.696196709199, 5460.208269800876, 5485.232067510552, 5494.670319780826, 5498.670079795225, 5517.393086760453, 5503.3120859892515, 5529.225908372851, 5551.528120109796, 5573.637713548606, 5580.665160090408, 5172.120739474299, 5188.8962220755375, 5192.0, 5208.166693329049, 5225.503577160163, 6668.566543174678, 6719.025741267537, 6766.458683305324, 6768.187817461887, 6793.558418702769, 6379.138816259792, 6400.807975760735, 6456.160699109086, 6554.80335589933, 6565.441937435324, 7091.0, 7188.931803078817, 7248.891266631004, 7259.491835571512, 7263.65871699019, 5672.290963629546, 5761.279840019997, 5761.740721667493, 5763.711814409263, 5804.767809287623, 7086.18508871476, 7251.818704532376, 7387.300920788195, 7407.222241664602, 7562.659680314399, 5870.006296788669, 5906.202662640574, 5938.910916336258, 5961.344252132262, 5964.747403045322, 5971.79098731551, 5984.102384642339, 6041.009700198342, 6051.122587224828, 6088.178095957078, 6415.871682566322, 6471.417572418411, 6495.740170393131, 6510.18622672166, 6517.478601711851, 7224.74713385029, 7245.637718114073, 7270.945712871604, 7335.706571737178, 7343.192248852622, 2104.2219324670937, 2115.714378558875, 2119.1629306424184, 2124.6069477146466, 2124.798144176301, 1452.1795185720034, 1533.463287849244, 1546.9767953480707, 1571.8506741859505, 1573.197669188722, 6131.724072416752, 6144.723487443076, 6159.566971046412, 6163.075538669235, 6235.532335074888, 7054.671958253764, 7184.784456466315, 7247.492675512769, 7269.963650181821, 7340.596267205248, 6120.234970628671, 6122.316363000211, 6189.50483961282, 6200.224971878515, 6207.441330280297, 3831.9042023949623, 3836.5204349456317, 3868.787216703052, 3873.8644147455266, 3875.8643447479203, 7097.716091356391, 7113.857722845514, 7127.821804454827, 7141.214466408691, 7147.0, 7490.325870671666, 7524.9247507525315, 7548.773536793795, 7579.924200758032, 7584.62076896153, 7048.682809273595, 7140.357367836816, 7163.641817909188, 7208.675609597476, 7233.168185658506, 7330.780076597711, 7355.338019578264, 7358.448116391399, 7375.262473752582, 7377.26227377258, 7261.419086473175, 7294.927050729637, 7327.230640782641, 7359.484836061424, 7379.667914943948, 6998.195207551197, 7015.859682806417, 7085.291470852873, 7150.785476435507, 7184.461165412719, 5972.820815375546, 5987.730552125252, 5990.6705131218205, 5995.310539288038, 6008.8798224036145, 6924.965375173293, 7087.539309944837, 7298.306660867209, 7300.342969132804, 7405.0, 6956.2695916930015, 6958.512904096665, 6990.825229369307, 7038.0, 7070.080889484334, 6760.715464061813, 6922.480813939075, 6955.339242771928, 6965.582065076112, 7005.964970175117, 6839.6580170990255, 6862.3823855851215, 6879.931200687929, 6920.9307906920285, 6944.4791640626145, 7007.7196912122945, 7022.332878376546, 7061.6469176542, 7077.433805295667, 7158.4273258140265, 6780.559263647847, 6812.591244525344, 6882.03651488782, 6898.689249042666, 6910.654467276516], "value": 5622.657281337512, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [945.3382632157492, 985.7535616095977, 985.9556319965601, 1009.8485227215918, 1011.6004178349557, 18913.810861891376, 19368.3221087262, 19733.703994440093, 19739.605207895835, 19742.703859442103, 19875.70186447201, 19889.900550497263, 19927.10328035238, 19970.301039463622, 20049.799502004975, 1063.9734006649837, 1084.1868598551087, 1087.3095584303944, 1088.7006073329858, 1090.4166271044992, 1040.7398150462384, 1110.5835311758092, 1112.1492058575197, 1112.2103306652286, 1113.7271368514685, 1161.181367136167, 1165.8950694437542, 1166.0554950490089, 1167.7255844876447, 1168.007193885195, 1164.9009834164106, 1173.2960223865698, 1173.325337930689, 1173.7828501727208, 1177.6055021567786, 851.2041241439213, 853.0488505316589, 853.8377708235478, 855.3072011670566, 855.9957200214021, 19610.215591376327, 19934.70097948532, 19974.80025199744, 20729.0, 21333.146674133015, 22627.88686056559, 22653.660195097087, 22999.0, 23174.304770856903, 23302.41743956398, 16040.679186416322, 16194.676106477922, 16363.0, 16385.09881956492, 16529.256183471774, 4004.599540046001, 4037.777922214277, 4039.3537034074407, 4041.6362527372676, 4051.4327994080854, 143606.99999999895, 143729.2813535936, 145053.0, 145261.2736936319, 145584.0, 16929.153542322834, 17353.2191051403, 17412.303507859797, 17518.0, 17519.82480175182, 27364.726352736616, 27613.0, 27679.44641107207, 27693.0, 27712.44575108527, 9079.909200908038, 9296.907030929739, 9350.018248083854, 9352.438853668802, 9373.718788436357, 4308.18144552534, 4377.562243775661, 4389.253826849444, 4392.121575684876, 4408.228560001987, 5857.004309267435, 5946.524278057745, 6046.818595442144, 6072.817815465543, 6098.481629061491, 1108.4568561405015, 1124.8818874018275, 1140.3500004997072, 1150.4592841364545, 1156.4795841871023, 739.2533541123397, 744.2185705009719, 753.1865585168006, 768.9384849212049, 772.0465225446569, 12017.519299227934, 12367.876321236852, 12590.496380144692, 12802.551910683082, 12894.67763305925, 746.9551826890404, 749.2919191364109, 750.4671683105057, 764.6024067484876, 769.7036640893184, 5956.702164891824, 5969.880602387928, 6034.396560344018, 6107.328193898667, 6167.96916015426, 135957.0, 135978.0, 137211.0, 141019.29490352687, 142419.2879035619, 116524.41737791426, 117804.41097794627, 118160.0, 120112.39943800225, 123113.0, 103001.0, 103326.48336758418, 103624.48187759014, 104245.0, 104556.47721761343, 10814.0, 11184.94407527957, 13585.796213056614, 14061.859381406464, 14154.150750954976, 50026.49973500364, 50692.23961640652, 51125.23312150395, 51387.48612513827, 52328.47671523388, 84864.0, 85529.57235213784, 88530.1146988522, 88978.55510722405, 105003.0, 19491.902540487776, 19771.40685779429, 19885.502862428555, 19894.60210795747, 20690.793092068885, 22165.113395464, 22283.44291392728, 22949.655755164018, 23142.884285578464, 24337.51324973526, 20089.698654519903, 20110.597788043866, 20296.695549566473, 20315.59368812645, 21281.36155915325, 19596.90201548983, 19764.209431622574, 20250.696239556713, 22143.66784498266, 22517.437064072874, 18845.434636960912, 18952.24191032343, 19064.523386915436, 21952.560948781254, 22298.21956231524, 14961.401543938557, 15058.623534411727, 15200.695986079996, 15332.8749514215, 15830.050196988217, 14898.478553250585, 15034.774478382615, 15638.84361156374, 15766.290516926996, 15804.0], "value": 10070.867276754527, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 94.0, 106.0, 104.0, 106.0, 110.0, 108.0, 106.0, 110.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 134.0, 162.0, 112.0, 152.0, 139.0, 119.0, 170.0, 113.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 162.0, 171.0, 163.0, 165.0, 165.0, 165.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 170.0, 77.0, 73.0, 73.0, 87.0, 98.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 135.0, 78.0, 78.0, 78.0, 134.0, 78.0, 78.0, 126.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 157.0, 150.0, 149.0, 150.0, 150.0, 151.0, 149.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 43.0, 43.0, 44.0, 43.0, 44.0, 44.0, 43.0, 46.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 36.0, 35.0, 36.0, 35.0, 36.0, 35.0, 35.0, 36.0, 37.0], "value": 35.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 74.0, 75.0, 74.0, 79.0, 73.0, 73.0, 74.0, 77.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 115.0, 114.0, 111.0, 109.0, 111.0, 116.0, 109.0, 152.0], "value": 116.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 169.0, 153.0, 157.0, 158.0, 153.0, 152.0, 164.0, 163.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 60.0, 60.0, 60.0, 58.0, 60.0, 62.0, 61.0, 59.0], "value": 60.7, "unit": "score"}]}]} 18:05:12 INFO - Return code: 0 18:05:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:05:12 INFO - # TBPL SUCCESS # 18:05:12 INFO - Running post-action listener: _package_coverage_data 18:05:12 INFO - Running post-action listener: _resource_record_post_action 18:05:12 INFO - [mozharness: 2017-09-02 01:05:12.548779Z] Finished run-tests step (success) 18:05:12 INFO - Running post-run listener: _resource_record_post_run 18:05:12 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 379744256; Read time: 8; Write time: 221688 18:05:12 INFO - TinderboxPrint: CPU usage
13.1% 18:05:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:05:12 INFO - TinderboxPrint: I/O write bytes / time
379,744,256 / 221,688 18:05:12 INFO - TinderboxPrint: CPU idle
8,219.3 (86.9%) 18:05:12 INFO - TinderboxPrint: CPU user
1,188.5 (12.6%) 18:05:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:05:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110018560; Read time: 0; Write time: 71488 18:05:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:05:12 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 269721600; Read time: 8; Write time: 150184 18:05:13 INFO - Running post-run listener: _upload_blobber_files 18:05:13 INFO - Blob upload gear active. 18:05:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:05:13 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 18:05:13 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'] 18:05:13 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 18:05:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:17 INFO - (blobuploader) - INFO - Done attempting. 18:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:18 INFO - (blobuploader) - INFO - Done attempting. 18:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:19 INFO - (blobuploader) - INFO - Done attempting. 18:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:05:20 INFO - (blobuploader) - INFO - Done attempting. 18:05:20 INFO - (blobuploader) - INFO - Iteration through files over. 18:05:20 INFO - Return code: 0 18:05:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:05:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:05:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88cfbcd50cf6bf3faaab8f20fa9d01f77fab047a8c5f35e4702848b7642fe7892af95e3f3f04384d76499ff974930705d640062e40ae0924e89c447d4ac9e7d6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89094c0e67d36ef2a425a5d1ecf55041c694301aed194203a43bcc28a20a539ce00b2603e5fc894a7699b45142aa43a951cb4c85289f1b902f3ed56fd71c5b9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/249fe1f7c6f769375920df46c1d08aa5c86069ca66bc29bfac087efe1173eadcfd9ca238732a7cf272dfce90bda9f60191edd7126f1d1b9016a98918de1625dc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b65fbfb3a4957684d8cb2a8e3a3f287b317a3c4e4174a3f7dca422b02eae25c4a059abe541912e4cf945c358727280746006c1f7a70a2b442a1572733526db5"} 18:05:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:05:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:05:20 INFO - Contents: 18:05:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88cfbcd50cf6bf3faaab8f20fa9d01f77fab047a8c5f35e4702848b7642fe7892af95e3f3f04384d76499ff974930705d640062e40ae0924e89c447d4ac9e7d6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89094c0e67d36ef2a425a5d1ecf55041c694301aed194203a43bcc28a20a539ce00b2603e5fc894a7699b45142aa43a951cb4c85289f1b902f3ed56fd71c5b9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/249fe1f7c6f769375920df46c1d08aa5c86069ca66bc29bfac087efe1173eadcfd9ca238732a7cf272dfce90bda9f60191edd7126f1d1b9016a98918de1625dc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b65fbfb3a4957684d8cb2a8e3a3f287b317a3c4e4174a3f7dca422b02eae25c4a059abe541912e4cf945c358727280746006c1f7a70a2b442a1572733526db5"} 18:05:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:05:20 INFO - Copying logs to upload dir... 18:05:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:05:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.855927 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-01 18:05:20.354089) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 18:05:20.358871) ========= 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=51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88cfbcd50cf6bf3faaab8f20fa9d01f77fab047a8c5f35e4702848b7642fe7892af95e3f3f04384d76499ff974930705d640062e40ae0924e89c447d4ac9e7d6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89094c0e67d36ef2a425a5d1ecf55041c694301aed194203a43bcc28a20a539ce00b2603e5fc894a7699b45142aa43a951cb4c85289f1b902f3ed56fd71c5b9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/249fe1f7c6f769375920df46c1d08aa5c86069ca66bc29bfac087efe1173eadcfd9ca238732a7cf272dfce90bda9f60191edd7126f1d1b9016a98918de1625dc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b65fbfb3a4957684d8cb2a8e3a3f287b317a3c4e4174a3f7dca422b02eae25c4a059abe541912e4cf945c358727280746006c1f7a70a2b442a1572733526db5"} build_url:https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/FumDpYGRS1uvlCElGgsUMw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88cfbcd50cf6bf3faaab8f20fa9d01f77fab047a8c5f35e4702848b7642fe7892af95e3f3f04384d76499ff974930705d640062e40ae0924e89c447d4ac9e7d6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89094c0e67d36ef2a425a5d1ecf55041c694301aed194203a43bcc28a20a539ce00b2603e5fc894a7699b45142aa43a951cb4c85289f1b902f3ed56fd71c5b9c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/249fe1f7c6f769375920df46c1d08aa5c86069ca66bc29bfac087efe1173eadcfd9ca238732a7cf272dfce90bda9f60191edd7126f1d1b9016a98918de1625dc", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b65fbfb3a4957684d8cb2a8e3a3f287b317a3c4e4174a3f7dca422b02eae25c4a059abe541912e4cf945c358727280746006c1f7a70a2b442a1572733526db5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-01 18:05:20.386373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 18:05:20.389733) ========= 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=51fc86400edbde9650d2781a000001d0-1504313067.250115-1374573928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-01 18:05:20.470172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 18:05:20.473498) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-01 18:05:20.473793) ========= ========= Total master_lag: 0.26 =========