builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1506854151.67 results: success (0) revision: 41286177c59c74ec37961b1edea34cc90d6f6dc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.673882) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.674385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.674661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.707457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.707844) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-01 03:35:51-- 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% 220M=0s 2017-10-01 03:35:51 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.858902) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.859195) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024375 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:51.908969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-01 03:35:51.909593) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 41286177c59c74ec37961b1edea34cc90d6f6dc5 --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 41286177c59c74ec37961b1edea34cc90d6f6dc5 --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=ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-01 03:35:51,962 truncating revision to first 12 chars 2017-10-01 03:35:51,962 Setting DEBUG logging. 2017-10-01 03:35:51,962 attempt 1/10 2017-10-01 03:35:51,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/41286177c59c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-01 03:35:52,890 unpacking tar archive at: mozilla-central-41286177c59c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-01 03:35:53.174046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:53.174357) ========= script_repo_revision: 41286177c59c74ec37961b1edea34cc90d6f6dc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:53.174752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:53.175034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-01 03:35:53.187999) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-10-01 03:35:53.188324) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:53 INFO - MultiFileLogger online at 20171001 03:35:53 in /builds/slave/test 03:35:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:35:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:53 INFO - {'append_to_log': False, 03:35:53 INFO - 'base_work_dir': '/builds/slave/test', 03:35:53 INFO - 'blob_upload_branch': 'Firefox', 03:35:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:53 INFO - 'branch': 'Firefox', 03:35:53 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:53 INFO - 'code_coverage': False, 03:35:53 INFO - 'config_files': ('talos/linux_config.py',), 03:35:53 INFO - 'default_actions': ('clobber', 03:35:53 INFO - 'read-buildbot-config', 03:35:53 INFO - 'download-and-extract', 03:35:53 INFO - 'populate-webroot', 03:35:53 INFO - 'create-virtualenv', 03:35:53 INFO - 'install', 03:35:53 INFO - 'setup-mitmproxy', 03:35:53 INFO - 'run-tests'), 03:35:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:53 INFO - 'disable_ccov_upload': False, 03:35:53 INFO - 'disable_stylo': False, 03:35:53 INFO - 'download_minidump_stackwalk': True, 03:35:53 INFO - 'download_symbols': 'ondemand', 03:35:53 INFO - 'enable_stylo': False, 03:35:53 INFO - 'enable_webrender': False, 03:35:53 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:35:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:53 INFO - 'gecko_profile': False, 03:35:53 INFO - 'gecko_profile_interval': 0, 03:35:53 INFO - 'installer_path': 'installer.exe', 03:35:53 INFO - 'log_level': 'info', 03:35:53 INFO - 'log_name': 'talos', 03:35:53 INFO - 'log_to_console': True, 03:35:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:53 INFO - 'opt_config_files': (), 03:35:53 INFO - 'pip_index': False, 03:35:53 INFO - 'suite': 'dromaeojs-e10s', 03:35:53 INFO - 'system_bits': '32', 03:35:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:53 INFO - 'title': 'talos-linux64-ix-087', 03:35:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:53 INFO - 'use_talos_json': True, 03:35:53 INFO - 'verify': 'False', 03:35:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:53 INFO - 'work_dir': 'build'} 03:35:53 INFO - [mozharness: 2017-10-01 10:35:53.374286Z] Running clobber step. 03:35:53 INFO - Running pre-action listener: _resource_record_pre_action 03:35:53 INFO - Running main action method: clobber 03:35:53 INFO - rmtree: /builds/slave/test/build 03:35:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:54 INFO - Running post-action listener: _resource_record_post_action 03:35:54 INFO - [mozharness: 2017-10-01 10:35:54.883713Z] Finished clobber step (success) 03:35:54 INFO - [mozharness: 2017-10-01 10:35:54.883812Z] Running read-buildbot-config step. 03:35:54 INFO - Running pre-action listener: _resource_record_pre_action 03:35:54 INFO - Running main action method: read_buildbot_config 03:35:54 INFO - Using buildbot properties: 03:35:54 INFO - { 03:35:54 INFO - "project": "", 03:35:54 INFO - "product": "firefox", 03:35:54 INFO - "who": "archaeopteryx@coole-files.de", 03:35:54 INFO - "installer_path": "public/build/target.tar.bz2", 03:35:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:35:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:35:54 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:35:54 INFO - "stage_platform": "linux64-qr", 03:35:54 INFO - "basedir": "/builds/slave/test", 03:35:54 INFO - "buildnumber": 95, 03:35:54 INFO - "platform": "ubuntu64_hw_qr", 03:35:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:35:54 INFO - "slavebuilddir": "test", 03:35:54 INFO - "taskId": "F2iTK5qMQVeznmLAcvCrmQ", 03:35:54 INFO - "branch": "mozilla-central", 03:35:54 INFO - "script_repo_revision": "production", 03:35:54 INFO - "revision": "41286177c59c74ec37961b1edea34cc90d6f6dc5", 03:35:54 INFO - "slavename": "talos-linux64-ix-087", 03:35:54 INFO - "repo_path": "mozilla-central" 03:35:54 INFO - } 03:35:54 INFO - Finding installer, test and symbols from parent task. 03:35:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F2iTK5qMQVeznmLAcvCrmQ'}, attempt #1 03:35:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F2iTK5qMQVeznmLAcvCrmQ'}, attempt #1 03:35:55 INFO - Task dependencies: QOqsB9orQMKqBzUJ4z8NXw 03:35:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw'}, attempt #1 03:35:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2 03:35:56 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.test_packages.json 03:35:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.crashreporter-symbols.zip 03:35:56 INFO - Running post-action listener: _resource_record_post_action 03:35:56 INFO - [mozharness: 2017-10-01 10:35:56.252778Z] Finished read-buildbot-config step (success) 03:35:56 INFO - [mozharness: 2017-10-01 10:35:56.252997Z] Running download-and-extract step. 03:35:56 INFO - Running pre-action listener: _resource_record_pre_action 03:35:56 INFO - Running main action method: download_and_extract 03:35:56 INFO - mkdir: /builds/slave/test/build/tests 03:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:56 INFO - trying https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.test_packages.json 03:35:56 INFO - Downloading https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:35:56 INFO - Downloaded 989 bytes. 03:35:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:35:56 INFO - Using the following test package requirements: 03:35:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:35:56 INFO - u'common': [u'target.common.tests.zip'], 03:35:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:35:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:35:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:35:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:35:56 INFO - u'mozbase': [u'target.common.tests.zip'], 03:35:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:35:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:35:56 INFO - u'web-platform': [u'target.common.tests.zip', 03:35:56 INFO - u'target.web-platform.tests.tar.gz'], 03:35:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:35:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:35:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.common.tests.zip 03:35:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:35:56 INFO - Fetch https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.common.tests.zip into memory 03:35:57 INFO - Content-Length response header: 55366785 03:35:57 INFO - Bytes received: 55366785 03:36:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.talos.tests.zip 03:36:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:36:08 INFO - Fetch https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.talos.tests.zip into memory 03:36:09 INFO - Content-Length response header: 14522385 03:36:09 INFO - Bytes received: 14522385 03:36:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:10 INFO - trying https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2 03:36:10 INFO - Downloading https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:36:12 INFO - Downloaded 61671575 bytes. 03:36:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2 03:36:12 INFO - mkdir: /builds/slave/test/properties 03:36:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:12 INFO - Contents: 03:36:12 INFO - build_url:https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2 03:36:12 INFO - Running post-action listener: _resource_record_post_action 03:36:12 INFO - Running post-action listener: find_tests_for_verification 03:36:12 INFO - Running post-action listener: set_extra_try_arguments 03:36:12 INFO - [mozharness: 2017-10-01 10:36:12.588836Z] Finished download-and-extract step (success) 03:36:12 INFO - [mozharness: 2017-10-01 10:36:12.589072Z] Running populate-webroot step. 03:36:12 INFO - Running pre-action listener: _resource_record_pre_action 03:36:12 INFO - Running main action method: populate_webroot 03:36:12 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:12 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['tresize', 03:36:12 INFO - 'tcanvasmark']}, 03:36:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:12 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['dromaeo_css', 03:36:12 INFO - 'kraken']}, 03:36:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:12 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'tests': ['damp', 'tps']}, 03:36:12 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['damp', 'tps']}, 03:36:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:12 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['dromaeo_dom']}, 03:36:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:36:12 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['basic_compositor_video', 03:36:12 INFO - 'glvideo']}, 03:36:12 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:36:12 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['ts_paint_webext', 03:36:12 INFO - 'tp5o_webext']}, 03:36:12 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:12 INFO - 'ts_paint', 03:36:12 INFO - 'tpaint', 03:36:12 INFO - 'sessionrestore', 03:36:12 INFO - 'sessionrestore_many_windows', 03:36:12 INFO - 'sessionrestore_no_auto_restore', 03:36:12 INFO - 'tabpaint', 03:36:12 INFO - 'cpstartup']}, 03:36:12 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['a11yr', 03:36:12 INFO - 'ts_paint', 03:36:12 INFO - 'tpaint', 03:36:12 INFO - 'sessionrestore', 03:36:12 INFO - 'sessionrestore_many_windows', 03:36:12 INFO - 'sessionrestore_no_auto_restore', 03:36:12 INFO - 'tabpaint', 03:36:12 INFO - 'cpstartup']}, 03:36:12 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:36:12 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:36:12 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['perf_reftest_singletons']}, 03:36:12 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['perf_reftest']}, 03:36:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:12 INFO - 'tsvgr_opacity', 03:36:12 INFO - 'tart', 03:36:12 INFO - 'tscrollx', 03:36:12 INFO - 'tsvg_static']}, 03:36:12 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['tsvgx', 03:36:12 INFO - 'tsvgr_opacity', 03:36:12 INFO - 'tart', 03:36:12 INFO - 'tscrollx', 03:36:12 INFO - 'tsvg_static']}, 03:36:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:36:12 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'talos_options': ['--disable-stylo'], 03:36:12 INFO - 'tests': ['tp5o']}, 03:36:12 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:12 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:36:12 INFO - 'talos_options': ['--mitmproxy', 03:36:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:12 INFO - '--firstNonBlankPaint'], 03:36:12 INFO - 'tests': ['tp6_google', 03:36:12 INFO - 'tp6_youtube', 03:36:12 INFO - 'tp6_amazon', 03:36:12 INFO - 'tp6_facebook']}, 03:36:12 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:12 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:36:12 INFO - 'talos_options': ['--disable-stylo', 03:36:12 INFO - '--mitmproxy', 03:36:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:12 INFO - '--firstNonBlankPaint'], 03:36:12 INFO - 'tests': ['tp6_google', 03:36:12 INFO - 'tp6_youtube', 03:36:12 INFO - 'tp6_amazon', 03:36:12 INFO - 'tp6_facebook']}, 03:36:12 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:12 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:36:12 INFO - 'talos_options': ['--stylo-threads=1', 03:36:12 INFO - '--mitmproxy', 03:36:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:12 INFO - '--firstNonBlankPaint'], 03:36:12 INFO - 'tests': ['tp6_google', 03:36:12 INFO - 'tp6_youtube', 03:36:12 INFO - 'tp6_amazon', 03:36:12 INFO - 'tp6_facebook']}, 03:36:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'talos_options': ['--xperf_path', 03:36:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:12 INFO - 'tests': ['tp5n']}, 03:36:12 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:12 INFO - 'talos_options': ['--disable-stylo', 03:36:12 INFO - '--xperf_path', 03:36:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:12 INFO - 'tests': ['tp5n']}}} 03:36:12 INFO - Running post-action listener: _resource_record_post_action 03:36:12 INFO - [mozharness: 2017-10-01 10:36:12.614314Z] Finished populate-webroot step (success) 03:36:12 INFO - [mozharness: 2017-10-01 10:36:12.614404Z] Running create-virtualenv step. 03:36:12 INFO - Running pre-action listener: _resource_record_pre_action 03:36:12 INFO - Running main action method: create_virtualenv 03:36:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:12 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:36:12 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:36:12 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:36:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:13 INFO - Installing pip...............done. 03:36:13 INFO - Return code: 0 03:36:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:36:13 INFO - Reading from file tmpfile_stdout 03:36:13 INFO - Output received: 03:36:13 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:36:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:13 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:36:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:36:13 INFO - Using env: {'DISPLAY': ':0', 03:36:13 INFO - 'HOME': '/home/cltbld', 03:36:13 INFO - 'LANG': 'en_US.UTF-8', 03:36:13 INFO - 'LANGUAGE': 'en_US:en', 03:36:13 INFO - 'LOGNAME': 'cltbld', 03:36:13 INFO - 'MAIL': '/var/mail/cltbld', 03:36:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:13 INFO - 'MOZ_NO_REMOTE': '1', 03:36:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:13 INFO - 'NO_EM_RESTART': '1', 03:36:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:13 INFO - 'PWD': '/builds/slave/test', 03:36:13 INFO - 'SHELL': '/bin/bash', 03:36:13 INFO - 'SHLVL': '1', 03:36:13 INFO - 'TERM': 'linux', 03:36:13 INFO - 'TMOUT': '86400', 03:36:13 INFO - 'USER': 'cltbld', 03:36:13 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:13 INFO - '_': '/tools/buildbot/bin/python'} 03:36:18 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:36:18 INFO - Downloading/unpacking pip>=1.5 03:36:18 INFO - Running setup.py egg_info for package pip 03:36:18 INFO - warning: no files found matching 'pip/cacert.pem' 03:36:18 INFO - warning: no files found matching '*.html' under directory 'docs' 03:36:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:36:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:36:18 INFO - Installing collected packages: pip 03:36:18 INFO - Found existing installation: pip 1.1 03:36:18 INFO - Uninstalling pip: 03:36:18 INFO - Successfully uninstalled pip 03:36:18 INFO - Running setup.py install for pip 03:36:18 INFO - warning: no files found matching 'pip/cacert.pem' 03:36:18 INFO - warning: no files found matching '*.html' under directory 'docs' 03:36:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:36:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:36:18 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:36:18 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:36:18 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:36:18 INFO - Successfully installed pip 03:36:18 INFO - Cleaning up... 03:36:18 INFO - Return code: 0 03:36:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:18 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:36:18 INFO - Using env: {'DISPLAY': ':0', 03:36:18 INFO - 'HOME': '/home/cltbld', 03:36:18 INFO - 'LANG': 'en_US.UTF-8', 03:36:18 INFO - 'LANGUAGE': 'en_US:en', 03:36:18 INFO - 'LOGNAME': 'cltbld', 03:36:18 INFO - 'MAIL': '/var/mail/cltbld', 03:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:18 INFO - 'MOZ_NO_REMOTE': '1', 03:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:18 INFO - 'NO_EM_RESTART': '1', 03:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:18 INFO - 'PWD': '/builds/slave/test', 03:36:18 INFO - 'SHELL': '/bin/bash', 03:36:18 INFO - 'SHLVL': '1', 03:36:18 INFO - 'TERM': 'linux', 03:36:18 INFO - 'TMOUT': '86400', 03:36:18 INFO - 'USER': 'cltbld', 03:36:18 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:18 INFO - '_': '/tools/buildbot/bin/python'} 03:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:18 INFO - Downloading/unpacking psutil>=3.1.1 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:20 INFO - Installing collected packages: psutil 03:36:20 INFO - Running setup.py install for psutil 03:36:20 INFO - building 'psutil._psutil_linux' extension 03:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:36:20 INFO - building 'psutil._psutil_posix' extension 03:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:20 INFO - Successfully installed psutil 03:36:20 INFO - Cleaning up... 03:36:21 INFO - Return code: 0 03:36:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:21 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:36:21 INFO - Using env: {'DISPLAY': ':0', 03:36:21 INFO - 'HOME': '/home/cltbld', 03:36:21 INFO - 'LANG': 'en_US.UTF-8', 03:36:21 INFO - 'LANGUAGE': 'en_US:en', 03:36:21 INFO - 'LOGNAME': 'cltbld', 03:36:21 INFO - 'MAIL': '/var/mail/cltbld', 03:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:21 INFO - 'MOZ_NO_REMOTE': '1', 03:36:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:21 INFO - 'NO_EM_RESTART': '1', 03:36:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:21 INFO - 'PWD': '/builds/slave/test', 03:36:21 INFO - 'SHELL': '/bin/bash', 03:36:21 INFO - 'SHLVL': '1', 03:36:21 INFO - 'TERM': 'linux', 03:36:21 INFO - 'TMOUT': '86400', 03:36:21 INFO - 'USER': 'cltbld', 03:36:21 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:21 INFO - '_': '/tools/buildbot/bin/python'} 03:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:22 INFO - Installing collected packages: mozsystemmonitor 03:36:22 INFO - Running setup.py install for mozsystemmonitor 03:36:22 INFO - Successfully installed mozsystemmonitor 03:36:22 INFO - Cleaning up... 03:36:22 INFO - Return code: 0 03:36:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:36:22 INFO - Using env: {'DISPLAY': ':0', 03:36:22 INFO - 'HOME': '/home/cltbld', 03:36:22 INFO - 'LANG': 'en_US.UTF-8', 03:36:22 INFO - 'LANGUAGE': 'en_US:en', 03:36:22 INFO - 'LOGNAME': 'cltbld', 03:36:22 INFO - 'MAIL': '/var/mail/cltbld', 03:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:22 INFO - 'MOZ_NO_REMOTE': '1', 03:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:22 INFO - 'NO_EM_RESTART': '1', 03:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:22 INFO - 'PWD': '/builds/slave/test', 03:36:22 INFO - 'SHELL': '/bin/bash', 03:36:22 INFO - 'SHLVL': '1', 03:36:22 INFO - 'TERM': 'linux', 03:36:22 INFO - 'TMOUT': '86400', 03:36:22 INFO - 'USER': 'cltbld', 03:36:22 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:22 INFO - '_': '/tools/buildbot/bin/python'} 03:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:23 INFO - Downloading/unpacking jsonschema==2.5.1 03:36: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 03:36: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 03:36: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 03:36: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 03:36:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:24 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:24 INFO - warning: no files found matching '*.txt' 03:36:24 INFO - no previously-included directories found matching 'build' 03:36:24 INFO - no previously-included directories found matching 'dist' 03:36:24 INFO - no previously-included directories found matching '.git*' 03:36:24 INFO - Installing collected packages: jsonschema, functools32 03:36:24 INFO - Running setup.py install for functools32 03:36:24 INFO - warning: no files found matching '*.txt' 03:36:24 INFO - no previously-included directories found matching 'build' 03:36:24 INFO - no previously-included directories found matching 'dist' 03:36:24 INFO - no previously-included directories found matching '.git*' 03:36:24 INFO - Successfully installed jsonschema functools32 03:36:24 INFO - Cleaning up... 03:36:24 INFO - Return code: 0 03:36:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:24 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:36:24 INFO - Using env: {'DISPLAY': ':0', 03:36:24 INFO - 'HOME': '/home/cltbld', 03:36:24 INFO - 'LANG': 'en_US.UTF-8', 03:36:24 INFO - 'LANGUAGE': 'en_US:en', 03:36:24 INFO - 'LOGNAME': 'cltbld', 03:36:24 INFO - 'MAIL': '/var/mail/cltbld', 03:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:24 INFO - 'MOZ_NO_REMOTE': '1', 03:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:24 INFO - 'NO_EM_RESTART': '1', 03:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:24 INFO - 'PWD': '/builds/slave/test', 03:36:24 INFO - 'SHELL': '/bin/bash', 03:36:24 INFO - 'SHLVL': '1', 03:36:24 INFO - 'TERM': 'linux', 03:36:24 INFO - 'TMOUT': '86400', 03:36:24 INFO - 'USER': 'cltbld', 03:36:24 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:24 INFO - '_': '/tools/buildbot/bin/python'} 03:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:24 INFO - Cleaning up... 03:36:24 INFO - Return code: 0 03:36:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:24 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:24 INFO - Using env: {'DISPLAY': ':0', 03:36:24 INFO - 'HOME': '/home/cltbld', 03:36:24 INFO - 'LANG': 'en_US.UTF-8', 03:36:24 INFO - 'LANGUAGE': 'en_US:en', 03:36:24 INFO - 'LOGNAME': 'cltbld', 03:36:24 INFO - 'MAIL': '/var/mail/cltbld', 03:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:24 INFO - 'MOZ_NO_REMOTE': '1', 03:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:24 INFO - 'NO_EM_RESTART': '1', 03:36:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:24 INFO - 'PWD': '/builds/slave/test', 03:36:24 INFO - 'SHELL': '/bin/bash', 03:36:24 INFO - 'SHLVL': '1', 03:36:24 INFO - 'TERM': 'linux', 03:36:24 INFO - 'TMOUT': '86400', 03:36:24 INFO - 'USER': 'cltbld', 03:36:24 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:24 INFO - '_': '/tools/buildbot/bin/python'} 03:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:26 INFO - Downloading docopt-0.6.1.tar.gz 03:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:26 INFO - Running setup.py install for blobuploader 03:36:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:26 INFO - Running setup.py install for requests 03:36:27 INFO - Running setup.py install for docopt 03:36:27 INFO - Successfully installed blobuploader requests docopt 03:36:27 INFO - Cleaning up... 03:36:27 INFO - Return code: 0 03:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:27 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:27 INFO - Using env: {'DISPLAY': ':0', 03:36:27 INFO - 'HOME': '/home/cltbld', 03:36:27 INFO - 'LANG': 'en_US.UTF-8', 03:36:27 INFO - 'LANGUAGE': 'en_US:en', 03:36:27 INFO - 'LOGNAME': 'cltbld', 03:36:27 INFO - 'MAIL': '/var/mail/cltbld', 03:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:27 INFO - 'MOZ_NO_REMOTE': '1', 03:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:27 INFO - 'NO_EM_RESTART': '1', 03:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:27 INFO - 'PWD': '/builds/slave/test', 03:36:27 INFO - 'SHELL': '/bin/bash', 03:36:27 INFO - 'SHLVL': '1', 03:36:27 INFO - 'TERM': 'linux', 03:36:27 INFO - 'TMOUT': '86400', 03:36:27 INFO - 'USER': 'cltbld', 03:36:27 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:27 INFO - '_': '/tools/buildbot/bin/python'} 03:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:27 INFO - Running setup.py (path:/tmp/pip-DGL3DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:27 INFO - Running setup.py (path:/tmp/pip-ojgtQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:27 INFO - Running setup.py (path:/tmp/pip-jJGNfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:27 INFO - Running setup.py (path:/tmp/pip-Gjyls8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:27 INFO - Running setup.py (path:/tmp/pip-p4feUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:27 INFO - Running setup.py (path:/tmp/pip-ZCVvuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:27 INFO - Running setup.py (path:/tmp/pip-532kXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:27 INFO - Running setup.py (path:/tmp/pip-XI3vdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:27 INFO - Running setup.py (path:/tmp/pip-9J9VfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:28 INFO - Running setup.py (path:/tmp/pip-Kamom4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:28 INFO - Running setup.py (path:/tmp/pip-NUjG3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:28 INFO - Running setup.py (path:/tmp/pip-IcaIrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:28 INFO - Running setup.py (path:/tmp/pip-XohR_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:28 INFO - Running setup.py (path:/tmp/pip-aDw4HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:28 INFO - Running setup.py (path:/tmp/pip-MHRd5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:28 INFO - Running setup.py (path:/tmp/pip-Qc53iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:28 INFO - Running setup.py (path:/tmp/pip-ILbp50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:28 INFO - Running setup.py install for manifestparser 03:36:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:28 INFO - Running setup.py install for mozcrash 03:36:28 INFO - Running setup.py install for mozdebug 03:36:28 INFO - Running setup.py install for mozdevice 03:36:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for mozfile 03:36:29 INFO - Running setup.py install for mozhttpd 03:36:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for mozinfo 03:36:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for mozInstall 03:36:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for mozleak 03:36:29 INFO - Running setup.py install for mozlog 03:36:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for moznetwork 03:36:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for mozprocess 03:36:29 INFO - Running setup.py install for mozprofile 03:36:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:29 INFO - Running setup.py install for mozrunner 03:36:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:30 INFO - Running setup.py install for mozscreenshot 03:36:30 INFO - Running setup.py install for moztest 03:36:30 INFO - Running setup.py install for mozversion 03:36:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:30 INFO - Cleaning up... 03:36:30 INFO - Return code: 0 03:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:30 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:30 INFO - Using env: {'DISPLAY': ':0', 03:36:30 INFO - 'HOME': '/home/cltbld', 03:36:30 INFO - 'LANG': 'en_US.UTF-8', 03:36:30 INFO - 'LANGUAGE': 'en_US:en', 03:36:30 INFO - 'LOGNAME': 'cltbld', 03:36:30 INFO - 'MAIL': '/var/mail/cltbld', 03:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:30 INFO - 'MOZ_NO_REMOTE': '1', 03:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:30 INFO - 'NO_EM_RESTART': '1', 03:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:30 INFO - 'PWD': '/builds/slave/test', 03:36:30 INFO - 'SHELL': '/bin/bash', 03:36:30 INFO - 'SHLVL': '1', 03:36:30 INFO - 'TERM': 'linux', 03:36:30 INFO - 'TMOUT': '86400', 03:36:30 INFO - 'USER': 'cltbld', 03:36:30 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:30 INFO - '_': '/tools/buildbot/bin/python'} 03:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:30 INFO - Running setup.py (path:/tmp/pip-jC0gTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:30 INFO - Running setup.py (path:/tmp/pip-Bfp3h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:30 INFO - Running setup.py (path:/tmp/pip-CteFsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:30 INFO - Running setup.py (path:/tmp/pip-g1Vilq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:30 INFO - Running setup.py (path:/tmp/pip-hpEVVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:30 INFO - Running setup.py (path:/tmp/pip-v9E8cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:31 INFO - Running setup.py (path:/tmp/pip-JN9phI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:31 INFO - Running setup.py (path:/tmp/pip-I8k9nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:31 INFO - Running setup.py (path:/tmp/pip-Oh6np2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:31 INFO - Running setup.py (path:/tmp/pip-h0oMQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:31 INFO - Running setup.py (path:/tmp/pip-QmPPAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:31 INFO - Running setup.py (path:/tmp/pip-_MJoVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:31 INFO - Running setup.py (path:/tmp/pip-McRPUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:31 INFO - Running setup.py (path:/tmp/pip-mJvOCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:31 INFO - Running setup.py (path:/tmp/pip-4gL1hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:31 INFO - Running setup.py (path:/tmp/pip-HTskk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:31 INFO - Running setup.py (path:/tmp/pip-ewTzit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:36:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:32 INFO - Downloading blessings-1.6.tar.gz 03:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:33 INFO - Installing collected packages: blessings 03:36:33 INFO - Running setup.py install for blessings 03:36:33 INFO - Successfully installed blessings 03:36:33 INFO - Cleaning up... 03:36:33 INFO - Return code: 0 03:36:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:33 INFO - Reading from file tmpfile_stdout 03:36:33 INFO - Current package versions: 03:36:33 INFO - argparse == 1.2.1 03:36:33 INFO - blessings == 1.6 03:36:33 INFO - blobuploader == 1.2.4 03:36:33 INFO - docopt == 0.6.1 03:36:33 INFO - functools32 == 3.2.3-2 03:36:33 INFO - jsonschema == 2.5.1 03:36:33 INFO - manifestparser == 1.1 03:36:33 INFO - mozInstall == 1.13 03:36:33 INFO - mozcrash == 1.0 03:36:33 INFO - mozdebug == 0.1 03:36:33 INFO - mozdevice == 0.51 03:36:33 INFO - mozfile == 1.2 03:36:33 INFO - mozhttpd == 0.7 03:36:33 INFO - mozinfo == 0.10 03:36:33 INFO - mozleak == 0.1 03:36:33 INFO - mozlog == 3.5 03:36:33 INFO - moznetwork == 0.27 03:36:33 INFO - mozprocess == 0.25 03:36:33 INFO - mozprofile == 0.28 03:36:33 INFO - mozrunner == 6.13 03:36:33 INFO - mozscreenshot == 0.1 03:36:33 INFO - mozsystemmonitor == 0.3 03:36:33 INFO - moztest == 0.8 03:36:33 INFO - mozversion == 1.4 03:36:33 INFO - psutil == 3.1.1 03:36:33 INFO - requests == 1.2.3 03:36:33 INFO - wsgiref == 0.1.2 03:36:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:33 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 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:33 INFO - Using env: {'DISPLAY': ':0', 03:36:33 INFO - 'HOME': '/home/cltbld', 03:36:33 INFO - 'LANG': 'en_US.UTF-8', 03:36:33 INFO - 'LANGUAGE': 'en_US:en', 03:36:33 INFO - 'LOGNAME': 'cltbld', 03:36:33 INFO - 'MAIL': '/var/mail/cltbld', 03:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:33 INFO - 'MOZ_NO_REMOTE': '1', 03:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:33 INFO - 'NO_EM_RESTART': '1', 03:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:33 INFO - 'PWD': '/builds/slave/test', 03:36:33 INFO - 'SHELL': '/bin/bash', 03:36:33 INFO - 'SHLVL': '1', 03:36:33 INFO - 'TERM': 'linux', 03:36:33 INFO - 'TMOUT': '86400', 03:36:33 INFO - 'USER': 'cltbld', 03:36:33 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:33 INFO - '_': '/tools/buildbot/bin/python'} 03:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:36:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:34 INFO - Installing collected packages: simplejson 03:36:34 INFO - Running setup.py install for simplejson 03:36:34 INFO - building 'simplejson._speedups' extension 03:36:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:36:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:36:35 INFO - Successfully installed simplejson 03:36:35 INFO - Cleaning up... 03:36:35 INFO - Return code: 0 03:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1269b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140e9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:36:35 INFO - Using env: {'DISPLAY': ':0', 03:36:35 INFO - 'HOME': '/home/cltbld', 03:36:35 INFO - 'LANG': 'en_US.UTF-8', 03:36:35 INFO - 'LANGUAGE': 'en_US:en', 03:36:35 INFO - 'LOGNAME': 'cltbld', 03:36:35 INFO - 'MAIL': '/var/mail/cltbld', 03:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:35 INFO - 'MOZ_NO_REMOTE': '1', 03:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:35 INFO - 'NO_EM_RESTART': '1', 03:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:35 INFO - 'PWD': '/builds/slave/test', 03:36:35 INFO - 'SHELL': '/bin/bash', 03:36:35 INFO - 'SHLVL': '1', 03:36:35 INFO - 'TERM': 'linux', 03:36:35 INFO - 'TMOUT': '86400', 03:36:35 INFO - 'USER': 'cltbld', 03:36:35 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:35 INFO - '_': '/tools/buildbot/bin/python'} 03:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:36 INFO - Cleaning up... 03:36:36 INFO - Return code: 0 03:36:36 INFO - Running post-action listener: _resource_record_post_action 03:36:36 INFO - Running post-action listener: _start_resource_monitoring 03:36:36 INFO - Starting resource monitoring. 03:36:36 INFO - [mozharness: 2017-10-01 10:36:36.090137Z] Finished create-virtualenv step (success) 03:36:36 INFO - [mozharness: 2017-10-01 10:36:36.090658Z] Running install step. 03:36:36 INFO - Running pre-action listener: _resource_record_pre_action 03:36:36 INFO - Running main action method: install 03:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:36 INFO - Reading from file tmpfile_stdout 03:36:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:36 INFO - Reading from file tmpfile_stdout 03:36:36 INFO - Output received: 03:36:36 INFO - Usage: mozinstall [options] installer 03:36:36 INFO - Options: 03:36:36 INFO - -h, --help show this help message and exit 03:36:36 INFO - -d DEST, --destination=DEST 03:36:36 INFO - Directory to install application into. [default: 03:36:36 INFO - "/builds/slave/test"] 03:36:36 INFO - --app=APP Application being installed. [default: firefox] 03:36:36 INFO - mkdir: /builds/slave/test/build/application 03:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:36:54 INFO - Reading from file tmpfile_stdout 03:36:54 INFO - Output received: 03:36:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:36:54 INFO - Running post-action listener: _resource_record_post_action 03:36:54 INFO - [mozharness: 2017-10-01 10:36:54.293186Z] Finished install step (success) 03:36:54 INFO - [mozharness: 2017-10-01 10:36:54.293440Z] Running setup-mitmproxy step. 03:36:54 INFO - Running pre-action listener: _resource_record_pre_action 03:36:54 INFO - Running main action method: setup_mitmproxy 03:36:54 INFO - Skipping: mitmproxy is not required 03:36:54 INFO - Running post-action listener: _resource_record_post_action 03:36:54 INFO - [mozharness: 2017-10-01 10:36:54.294566Z] Finished setup-mitmproxy step (success) 03:36:54 INFO - [mozharness: 2017-10-01 10:36:54.294801Z] Running run-tests step. 03:36:54 INFO - Running pre-action listener: _resource_record_pre_action 03:36:54 INFO - Running pre-action listener: _set_gcov_prefix 03:36:54 INFO - Running main action method: run_tests 03:36:54 WARNING - Try message not found. 03:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:36:54 INFO - Python 2.7.3 03:36:54 INFO - Return code: 0 03:36:54 INFO - grabbing minidump binary from tooltool 03:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:54 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 0x140bd60>, '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 0x140ca60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x140cef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:36:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:36:54 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:36:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:36:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:36:54 INFO - Return code: 0 03:36:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:36:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:36:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:36:54 INFO - ENV: RUST_BACKTRACE is now full 03:36:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:36:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:36:54 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/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:36:54 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/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:36:54 INFO - Using env: {'DISPLAY': ':0', 03:36:54 INFO - 'HOME': '/home/cltbld', 03:36:54 INFO - 'LANG': 'en_US.UTF-8', 03:36:54 INFO - 'LANGUAGE': 'en_US:en', 03:36:54 INFO - 'LOGNAME': 'cltbld', 03:36:54 INFO - 'MAIL': '/var/mail/cltbld', 03:36:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:36:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:36:54 INFO - 'MOZ_ACCELERATED': '1', 03:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:54 INFO - 'MOZ_NO_REMOTE': '1', 03:36:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:36:54 INFO - 'MOZ_WEBRENDER': '1', 03:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:54 INFO - 'NO_EM_RESTART': '1', 03:36:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:54 INFO - 'PWD': '/builds/slave/test', 03:36:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:36:54 INFO - 'RUST_BACKTRACE': 'full', 03:36:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:36:54 INFO - 'SHELL': '/bin/bash', 03:36:54 INFO - 'SHLVL': '1', 03:36:54 INFO - 'TERM': 'linux', 03:36:54 INFO - 'TMOUT': '86400', 03:36:54 INFO - 'USER': 'cltbld', 03:36:54 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:54 INFO - '_': '/tools/buildbot/bin/python'} 03:36:54 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/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:36:54 INFO - mozversion application_buildid: 20171001093730 03:36:54 INFO - mozversion application_changeset: 41286177c59c74ec37961b1edea34cc90d6f6dc5 03:36:54 INFO - mozversion application_display_name: FirefoxNightly 03:36:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:36:54 INFO - mozversion application_name: Firefox 03:36:54 INFO - mozversion application_remotingname: firefox 03:36:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:36:54 INFO - mozversion application_vendor: Mozilla 03:36:54 INFO - mozversion application_version: 58.0a1 03:36:54 INFO - mozversion platform_buildid: 20171001093730 03:36:54 INFO - mozversion platform_changeset: 41286177c59c74ec37961b1edea34cc90d6f6dc5 03:36:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:36:54 INFO - mozversion platform_version: 58.0a1 03:36:54 INFO - using testdate: 1506854214 03:36:54 INFO - actual date: 1506854214 03:36:54 INFO - starting webserver on 'localhost:41001' 03:36:54 INFO - SUITE-START | Running 2 tests 03:36:54 INFO - TEST-START | dromaeo_css 03:36:54 INFO - Initialising browser for dromaeo_css test... 03:36:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41001/getInfo.html -profile /tmp/tmpMfYajz/profile 03:36:54 INFO - TEST-INFO | started process 1349 (/builds/slave/test/build/application/firefox/firefox http://localhost:41001/getInfo.html) 03:37:03 INFO - TEST-INFO | 1349: exit 0 03:37:03 INFO - Browser initialized. 03:37:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:03 INFO - Using env: {'DISPLAY': ':0', 03:37:03 INFO - 'HOME': '/home/cltbld', 03:37:03 INFO - 'JSGC_DISABLE_POISONING': '1', 03:37:03 INFO - 'LANG': 'en_US.UTF-8', 03:37:03 INFO - 'LANGUAGE': 'en_US:en', 03:37:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:37:03 INFO - 'LOGNAME': 'cltbld', 03:37:03 INFO - 'MAIL': '/var/mail/cltbld', 03:37:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:03 INFO - 'MOZ_ACCELERATED': '1', 03:37:03 INFO - 'MOZ_CRASHREPORTER': '1', 03:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:37:03 INFO - 'MOZ_NO_REMOTE': '1', 03:37:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:03 INFO - 'MOZ_WEBRENDER': '1', 03:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:03 INFO - 'NO_EM_RESTART': '1', 03:37:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:03 INFO - 'PWD': '/builds/slave/test', 03:37:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:03 INFO - 'RUST_BACKTRACE': 'full', 03:37:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:37:03 INFO - 'SHELL': '/bin/bash', 03:37:03 INFO - 'SHLVL': '1', 03:37:03 INFO - 'TERM': 'linux', 03:37:03 INFO - 'TMOUT': '86400', 03:37:03 INFO - 'USER': 'cltbld', 03:37:03 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:03 INFO - '_': '/tools/buildbot/bin/python'} 03:37:03 INFO - TEST-INFO | started process 1611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfYajz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:03 INFO - PID 1611 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:37:04 INFO - PID 1611 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:37:04 INFO - PID 1611 | 03:37:04 INFO - PID 1611 | (/builds/slave/test/build/application/firefox/firefox:1670): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:37:04 INFO - PID 1611 | 03:37:14 INFO - PID 1611 | RSS: Main: 207757312 03:37:14 INFO - PID 1611 | 03:40:11 INFO - PID 1611 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41001/tests/dromaeo/cssquery-ext.html) 03:40:13 INFO - PID 1611 | RSS: Main: 202625024 03:40:13 INFO - PID 1611 | 03:43:15 INFO - PID 1611 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-ext.html (next: http://localhost:41001/tests/dromaeo/cssquery-jquery.html) 03:43:16 INFO - PID 1611 | RSS: Main: 202174464 03:43:16 INFO - PID 1611 | 03:46:18 INFO - PID 1611 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41001/tests/dromaeo/cssquery-mootools.html) 03:46:18 INFO - PID 1611 | RSS: Main: 202854400 03:46:18 INFO - PID 1611 | 03:49:20 INFO - PID 1611 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41001/tests/dromaeo/cssquery-prototype.html) 03:49:21 INFO - PID 1611 | RSS: Main: 202850304 03:49:21 INFO - PID 1611 | 03:52:25 INFO - PID 1611 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41001/tests/dromaeo/cssquery-yui.html) 03:52:25 INFO - PID 1611 | RSS: Main: 205914112 03:52:25 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | Cycle 1(1): loaded http://localhost:41001/tests/dromaeo/cssquery-yui.html (next: http://localhost:41001/tests/dromaeo/cssquery-dojo.html) 03:55:27 INFO - PID 1611 | RSS: Main: 206553088 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | __start_tp_report 03:55:27 INFO - PID 1611 | _x_x_mozilla_page_load 03:55:27 INFO - PID 1611 | _x_x_mozilla_page_load_details 03:55:27 INFO - PID 1611 | |i|pagename|runs| 03:55:27 INFO - PID 1611 | |0;dojo.html;3174.142981395022;3192.1381227068678;3192.888248911288;3202.151429871083;3212.1166679163234;6197.380261973801;6239.844003899905;6275.5920865143735;6277.654728989904;6329.651869147195;6151.630902145863;6168.290646575645;6210.596311239767;6229.159063526423;6237.875242495147;5618.747156377953;5696.401877802833;5698.458646428583;5709.1150871614755;5721.485066344028;5751.309842818868;5787.884242315151;5826.708664566776;5829.7376618052285;5855.736491857855;5826.708664566755;5832.445917637818;5874.765009399619;5904.822855314347;5915.349311575723;5590.580706447033;5722.170285308649;5728.971355143198;5733.684647344395;5864.032434648278;5707.286589176353;5748;5755.597108202427;5777.133429985493;5790.160426738099;6132.6013809102715;6156.630602163839;6199.380061993809;6228.4394404503355;6337.112804207414;6632.801015969529;6656.83357916056;6677.866442671119;6702.162229721285;6703.966480167568;6851.9657401713175;6854.280300568418;6895.586264824076;6898.517103802736;6908.516403851732;6214.8135555933395;6243.812685619393;6261.467775239064;6302.590331628429;6309.936900630981;6687.164104486939;6911.447084233249;6976.058232138596;6980.755673551402;6994.090768200102;6423.068655044993;6423.678816059271;6427.967860160669;6461.06314584392;6475.870482590321;6446.258680251831;6563.310852360529;6643.800685979331;6727.730890764413;6750.864982700318;6621.808074546531;6702.19573651165;6724.865502689919;6782.220044694924;6799.014142949343;6714.160729908762;6726.260111387744;6770.898436523456;6775.627340496221;6823.078884350549;5151.2530683050745;5232.92150617741;5274.446183150714;5340.759665815048;5356.062689029404;4566.109608626286;4569.9314510282375;4612.584867361954;4641.976790116028;4659.603933665677;5738.856528586819;5794.913076303858;5802.709864506758;5807.8548036299435;5848.0350742127075;6702.497312701469;6708.094407255056;6800.6939687714175;6800.727970881208;6804.183497980175;5710.314762228476;5816.1566572846705;5817.94182058174;5854.736536855852;5856.326522449887;5667.971660141756;5669.461401166883;5705.828825135252;5751.223584815996;5761.135829625506;6503.739850406026;6541.247756508063;6567.737290508422;6595.70319335631;6613.3056029117215;6771.492138089663;6778.694958726771;6843.794686159423;6877.58734475913;6899.827504312432;6498.155239818793;6501;6504.284528701934;6531.640759758259;6577.736890524326;6482.611043337415;6586.1438013058;6589.901151482636;6720.697568609522;6789.626570538668;6663.167104111986;6743.797686069426;6759.526833121831;6759.763408280686;6760.9520524318805;6510.869782604226;6544.083828263952;6578.210614726264;6629.933700662931;6630.469562434897;6503.02454631809;6521.739130434729;6527.9673601633585;6592.406683398517;6613.636250006296;6427.164468619237;6432.292447830641;6513.088167656437;6514.2834288229205;6514.706838192387;6387.233531976192;6441.1626488556185;6526;6547.345265473415;6558.737650494118;6343.0485427186295;6409.775657851953;6418.133551970611;6425.839354016;6441.323661015525 03:55:27 INFO - PID 1611 | |1;ext.html;878.367575345751;901.8511945528988;902.467544148952;904.8597467392548;906.1799071839985;39112.2177556449;39940.40089398661;42922.14155716884;43012;43175;39810.60189398105;40065.59934400655;40083.79958100205;40125.19749605006;40233.79883100588;7172.139343278801;7269.927300727004;7328.083989501312;7362.263773622622;7387.852242955138;7748.573828439462;7953.244441778022;7967.601619918981;7976.880346794803;8020.438569300151;7990.960045199795;8058.516489010678;8062.153473885245;8070.273675369215;8073.919260807375;7948.523088614702;7978.9202107979045;8041.919580804176;8181;8194.30348420385;7897.091834439056;7903.36773058154;7985.800354991114;7998.680052797881;8001.079875814297;37658;38216.80891595524;38218.61781382179;38325.80837095824;38412;3515.1739341254784;3541.38025845476;3554.680078792921;3557.484164796116;3596.28074385124;31716.524252136238;31734.04797856068;31768;31935.201619959455;32014.359712805846;5156.716380599066;5164.122099243138;5174.09453345663;5199.610029247821;5247.842564723064;193130;193785;194775;195110.99999999857;195757.02121489443;41378.1724365511;42052.36921446181;48315;48721.512784871695;48741.75629121832;44872;52262.73868630632;52961.47038529642;53131.73434132805;53319.20021199685;16231.756523652155;16579.751303730452;16648.75026874598;16728.58178545522;16743.07913064793;13496.595102146952;13514.526991555249;13544.051916365957;13571;13595.796063059062;14688.192149431883;14692.779608305884;14752.18862962526;14857.182854942866;14864;5759;5777.653340799481;5910.704464776744;5933.703314834241;5979.940200597938;986.8519722041608;990.1732053735068;991.7966816802539;1000.7097941597001;1001.2140469731372;22368;22624;22651.88674056619;22735.317940461813;22885.427864303194;1080.103514083309;1082.3181395720803;1091.2743025887855;1096.6929259807266;1116.6594188772503;12036.939815300868;12140.15018948665;12151.756964860653;12176.086793490524;12187.878121218851;231125;231248;231546;231627;232678;53543.46456535385;53638;53650.73174634102;54117.72941135348;54195.729021354644;1413.6607214268706;1449.8622630850052;1450.0574626492653;1475.4835807467516;1484.7624380099132;21646;22429.21497747571;22463.438414039127;22620.886895565418;22874.085036599015;37888.81055594815;38055;38278.23443531058;38319.23361532809;38353.23293534169;198309;198493;198497;199351;199704;31656.67604901452;32454.675453245167;32506.51240231351;32612.34775304528;34765;38956.80521597374;42264.78867605642;42803.57196427996;44476.55523444724;44721.776391119136;32084;32184.19539511531;32582.83708581442;32722.672773272916;32761;31207.063788086394;31367.68632313739;31571.210719731273;31582;31928;36226.4566031515;36477.08807279839;36585.45121823122;36635.45046824247;36755.81622091872;30903.536446953764;31669.841650791597;31861.20346991344;31946;32321.35357292794;22944.885275573517;22996.770032299464;23127.4218144541;23566.175183869167;23903.402414939766 03:55:27 INFO - PID 1611 | |2;jquery.html;567.347550317135;571.9370869204389;585.8564651660341;590.309338074453;613.7238242790745;21634.350969470903;22482;22542;22792.88603556982;22810;22469.887650561766;22644.207452739156;24546.877265613646;24895.75104248957;25140.62289065661;6428.742850285983;6572.408483236508;6618.073469714244;6631.403173714365;6635.104260924762;6509.9023514647315;6614.173228346457;6630.138082049327;6634.004899265101;6634.0712300278;6334.208223972004;6533.640649764261;6634.767783127591;6635.601863888158;6642.701078451457;6509.869802603968;6577.6053436793945;6578.703958321863;6620.271770105284;6622.503312251552;5973.492253158487;6120.540959428016;6177.135201071854;6191.473724733403;6203.4416902479;27314.31714207141;27919;27975;27982.720172798417;28038.158855234375;2003.2387692676834;2032.6442872497403;2042.6425375559365;2049.692546118094;2055.0341339570377;18558.536036599195;18766;19115.330963416214;19287.903560482107;19289.03554822253;2379.512199998996;2454.349597356702;2463.322586288767;2469.740677228901;2474.8020158387285;113949;117064.41467792606;118410.99999999914;118941;136473;14639.560813175622;14931.626709332353;14980.631073043696;15000.174990375415;15110.848891510945;23738.169164079176;23779.881100594386;23780.762192377853;23834.404139896295;23862.284131476084;10039.297249192487;10180.592776288866;10208.897911020944;10307.175425965905;10371.274010819321;9532.95233523828;9704.70885873425;9740.707778766648;9749.561269742879;9783.315167938319;8922.464652120894;8927.955360223157;9063.957644870792;9082.091790820865;9293.117153870371;2713.213168181245;2741.3420779012895;2789.470000699901;2821.195959151673;2835.376217232206;912.0924679943498;920.6087412849512;940.9576569054409;952.3761935931975;960.9423434593947;18227.72658410125;19096.427107186806;19100.904495477433;19150.904245478963;19610.803891961183;1010.1565193063874;1020.7856350166549;1023.4268809466722;1023.8157131716214;1024.1243736605245;10385.169186465064;10488.895111048945;10707.250492465453;10725.51735171919;10788.51451684676;439194;447985;448401;453191;453254;114941;116049.41975290238;116428.41785791186;116486.41756791332;117170;1016.5425558498705;1125.352922069813;1143.8856114388495;1158.4555259028243;1181.208590244521;20301.59396812085;20334.89832550828;20429.897850510653;20663.070161842454;20821;57143;57964.71017644885;58538.7073064632;59210.70394647999;59809.40190598038;69260.30739692539;71761.64119179579;72836.63581682058;73360.26639733747;73822.26177738154;14452.638684032563;14575.927120364331;14712.779308310597;14736.705265894409;14773.482928097465;22636.320910372717;22832.543349133255;23093.88453057724;23178.768212318337;23225.187118450773;17872.374466893598;18080.095995199925;18304.81695183031;18421.81578184201;18498.075096244866;15692.038495188102;16163.272652730891;16192.514224573282;16688;16967;18801.529961751065;18819.90590047041;18939.90530047341;19123.90438047801;19151.425457236306;13521.121127126706;14356.928215358856;14445.205513696848;14488.710225795636;14509.201993890438;17824.732629010316;18151.727724083885;18189.909050454662;18192.727109093637;18356 03:55:27 INFO - PID 1611 | |3;mootools.html;1318.3803612302218;1370.2874505257273;1372.0464277327255;1377.1255252914402;1377.8415482219546;14293.49972750954;15057.62355941102;15144.924275378635;15152.242387880604;15178.165200913945;14705.632359190999;14808.925955370236;14825;14862.33119509622;14885.106893586393;2654.4558365535117;2746.1624204617583;2752.174347695693;2772.8613569321556;2774.1954833098375;2740.6985231624503;2815.4650616382924;2822.463731890934;2826.0956493921954;2828.321202911297;2731.754142127208;2769.0862015534826;2776.7778577713834;2779.791515636325;2782.095818858869;2630.053180854891;2641.4981153580757;2661.9334516637045;2676.464707058596;2679.1426743442107;2619.973800261992;2650.178444682155;2661.507621090085;2665.9333516662045;2669.6796384433796;14094.788578171336;14349.354279057363;14355.78466323006;14385.064970776866;14441.35013924376;7712.922870771276;8007.839843203162;8097.878531822027;8104.47320924144;8118.75643730689;5204.401493828221;5406.91889621656;5497.532709719679;5539.501444869981;5628.296462942132;1894.2233684189555;1909.1981367825547;1944.0862794486568;1946.8929208893505;1951.5706544560173;22409.66385504219;23129.53740925172;24661.383465413328;25276.747232527807;25404.49191016188;7215.422766178693;7296.306850849161;7334.853302933911;7436;7486.5508069516;19685.704714429296;19730.210791568177;19742.012899354973;19745.210191592174;19747.703784443245;8168.264856162974;8216.21945915137;8216.34269258458;8299.377546684023;8304.045034820952;7106.360427561544;7429.034225550644;7432.256774322633;7466.402687784964;7547.358474529617;5504.614676972654;5508.504234618904;5657.6039677223025;5665.830025099253;5898;1691.4249155287262;1733.54927718794;1735.3318972195543;1753.2636292757072;1754.4385796544982;881.0660699658382;894.8612964990436;895.4224525181222;899.7705585075895;912.6896855069308;8223;8439.535825529532;8462.89982302309;8498.447600905922;8583.098774628574;689.2659317826499;733.2667332667332;739.1241378965835;739.3567596191348;740.034255296832;4554.339620754972;4596.17268891596;4609.700369475973;4737.2183589708;4748.596369308648;20258.08838602237;21301;21320.253791117237;21348.573028539344;21394.78605213928;20097.99510024493;20375.184992600425;20466;20511.17955281802;20665.896670516853;9344.999999999864;9749.756256093655;9985.450800205914;10905.727356816144;11171.776564468828;8295.211954864279;8579.442336248374;8620.224179823595;8716.084811094745;8817.206451419403;17248.310067597657;18103.728444073087;18299.634007320044;18499.260029599205;18512.629747405244;17857.196426161114;18204.81795182031;18216.089195540437;18236.726449103007;19462.513437164183;11777.705557360792;12044.096692748255;12070;12152.453139608562;12255.69360765988;13371.729685679846;13693.452261909411;13696.726065478833;13698.726025479635;13715.931420342835;10856.131509479064;10867.673969780919;11082.22424430282;11121.555137794398;11126.833097503706;10256.282060255711;10338.638147664795;10538;10879.782404352027;10883.129349652167;10097.646582369582;10133;10195.592176313161;10197.439140847027;10258.589656413958;7231.746888858865;7315.231900650355;7372.225916278713;7409.777706668809;7429.962850185714;7503.137139229058;7640.197779233323;7709.383249339927;7734.7679569613;7751.37988960893 03:55:27 INFO - PID 1611 | |4;prototype.html;508.56263613292583;525.1964494323685;536.5841472858534;542.3708498142156;544.5752313195707;6069.696515174241;6142.385761423855;6152.4462798348195;6183.567150299481;6215.844603884905;6024.644454997623;6044.425779550936;6052.425019623129;6092.451679348857;6104;5128.153854613994;5140.4859514048485;5143.151380022292;5187.936473023021;5188.818391356303;5092.643514953955;5101.948980510203;5135.922961155586;5155.040695061655;5170.896582068356;4722.527747225285;4934.728589927553;4952.727599981999;4959.380077490314;5082.618803589746;4917.237828136626;4943.77753001114;4954.603631709455;4956.90086198274;4973.204287314049;4435.29035354345;4443.200223959686;4456.977715111404;4475.261581838992;4514.277715565494;5890;5936.821895343147;5991.161237426763;5993.160957465958;6024.909626355608;5628;5631.718414079321;5639.887202255932;5660.66036037835;5664.2636457260705;6407.903881441782;6411.615303081783;6479.546431749779;6506.512011599101;6536.215654121488;4633.142868569292;4773.665843390964;4842.394700662418;4850.975745121252;4909.214525675875;6556.803295901131;6642.335766423319;6670.866582668319;6679.732810687567;6696.397324240842;4968.428630707443;4980;4991.5541384721955;5014.147594908802;5024.773885175176;5071.163258062378;5074.746262686851;5082.74586270685;5100.183970564692;5105.132127538327;5564.8330550083565;5566.666000040011;5620.831375058755;5624.71876406178;5662.971685141631;6507.577007494498;6530.1510803596175;6533.3339998300125;6542.967285163639;6555.704993275314;1744.1366523570914;1750.9912450437666;1754.333353325728;1758.2791055667115;1758.3933542927668;1147.5696613769837;1232.1744431231098;1234.8888600026041;1235.407004637779;1243.4777393494753;5531.308586426697;5545.667259964334;5573.164025396142;5577.135543990688;5644.491995720405;6487.481001519867;6493.642849643315;6537.5096867734155;6548.607083575001;6562.507811914125;5539.642787517004;5594.888102237933;5599.356074051455;5617.887642247132;5632.155176723524;3400.4559270516597;3409.6419875913166;3419.897403077912;3441.896743097661;3472.7048200903205;6295;6315.052742088724;6369.617822930639;6370.968145159244;6429.324920883333;6607.9669601651685;6615.338466153443;6661.633610151392;6699.899501507482;6721.1262535871;5879.148068358453;6252.562320637512;6253.155823963707;6357.936420635827;6391.904121438182;6406.327335629691;6442.774502892376;6503.382178693017;6565.934340656723;6576;6487.3836985486305;6518;6581;6597.4392176663605;6606.8348291293105;6249.312575616769;6301.40136687014;6347.460465860268;6442.645654488861;6460.86647975722;4794.496577859414;4947.886725486736;4960.50394960501;4967.776450059684;4973.626977976739;6318.9052164216655;6431.549791514549;6483.902741458976;6513.8697226056165;6563.9343606565235;6223.782167624111;6293.905591416041;6316.810495685137;6339.890519159221;6390.360963903572;6339.587926784744;6355.777547785805;6366.3633636637815;6399.568164097613;6444.45222156122;6290.748370065146;6296.087067375296;6304.369563043659;6329.683515824282;6357.300696923242;6346.460550853045;6396.296407395276;6417.390347917127;6453.193350831146;6494.220693516808;6210.782622608187;6231.906521402092;6249.218847644044;6265.530085243534;6293.576972865389 03:55:27 INFO - PID 1611 | |5;yui.html;882.8057827277996;906.0576999920083;908.950007749574;921.5069937583394;930.9487978161201;17367.565810854718;17872;17878.195481203344;17908.194131264092;17918.19368128434;18720.438386848382;18744.625107497843;18964.715529267072;19178.616427671437;19321.51696207592;939.1219210038602;968.9224862011022;971.2084651009404;972.3145182646217;973.060996138726;974.5906719177926;986.654670865195;992.1170158558888;994.2741798487073;996.9980169929211;976.2726768557435;1008.7478130467383;1010.4846528270598;1012.1902478017556;1013.6401577440013;993.4039576254189;993.5677980078689;999.3404353126901;1000.8098461292332;1006.8288390973552;719.8200449887528;738.818989347608;746.932776050158;749.6738918570385;752.259024860512;19390.127444265043;19462.416127516055;19627.509312267164;19641.116149773294;19641.41075767729;21435.892820535955;21681;22101.557968840694;22170.11319547216;22411.103555857746;17427.215775290144;17603.471895843144;17766;17894.55263618407;18180.090995450308;3696.3346597612417;3781.716371272166;3782.602826703184;3782.8486860525823;3785.4889589905288;136299;137459;138565.3071734645;138738;142805;16664.83335166657;16904;16932.730045246655;17175.656486870193;17286.481405557854;30847.2288192797;31421.37157256842;31439.214019649233;31892.521612175835;32302.83848580789;9027.00702922678;9085.863712044325;9139.314551408672;9145.77135571616;9170.082991700776;4174.958250417518;4273.188094262143;4335.739855608674;4378.190034843564;4393.956060439355;5539.584531160179;5625.240592519957;5662.952353814558;5668.291463567054;5687.175359572839;1006.9848952265722;1029.5006921642996;1048.2347886043078;1051.3849398102195;1054.383185836279;656.9934300657028;670.1422179610107;674.6727836999052;677.5968298862169;697.104221075915;11007.504662290215;11366.488508017159;11752.647420577396;12271.325077120844;12289;618.3352895637119;619.5693992675137;622.1911515030442;631.4537924695197;644.7839973608893;5514.641548299428;5572.219889215513;5578.612488700415;5652.293463317085;5762.855928601818;124463.2104934416;127159;129182;129246;132426;113136.43431782788;115905;116821.41589291999;117422;118802.40598796951;95860.52069739606;101524;101960;102520;104291.99999999849;10188.643397481053;10300.793984120126;10411.843822342822;10656.57373705043;10822.67531974042;45275.320870187636;46218;46938;47399.76300118477;47604;60655.393446064976;61666.69166654138;62995;63156;63362;15398.9230053849;15420.768688469458;15661.84338156604;15691.686166276382;15801.841981580037;17036.82963170402;17343.392981245597;17368.26317368253;17477.300907963538;17787.644247115244;16178.433754818525;16266;16381.426650067191;16419.83580164183;16660.833391666412;16162.434314798926;16356.67286654284;16450.177491125636;16579.50261492157;16597.834021660114;15859.444919428226;15955.8404415959;16140;16149.19254037317;16470.258838352544;11620.5351785931;11782.823257651313;11862.051035916933;11940.70148246266;11942.761144777229;12055.276683399024;12120.75758484843;12151.513939442324;12395.008399328213;12481.625551233477 03:55:27 INFO - PID 1611 | __end_tp_report 03:55:27 INFO - PID 1611 | __start_cc_report 03:55:27 INFO - PID 1611 | _x_x_mozilla_cycle_collect,284 03:55:27 INFO - PID 1611 | __end_cc_report 03:55:27 INFO - PID 1611 | __startTimestamp1506855327971__endTimestamp 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | ------- Summary: start ------- 03:55:27 INFO - PID 1611 | Number of tests: 6 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | [#0] dojo.html Cycles:165 Average:6175.16 Median:6427.16 stddev:739.53 (11.5%) stddev-sans-first:703.33 03:55:27 INFO - PID 1611 | Values: 3174.1 3192.1 3192.9 3202.2 3212.1 6197.4 6239.8 6275.6 6277.7 6329.7 6151.6 6168.3 6210.6 6229.2 6237.9 5618.7 5696.4 5698.5 5709.1 5721.5 5751.3 5787.9 5826.7 5829.7 5855.7 5826.7 5832.4 5874.8 5904.8 5915.3 5590.6 5722.2 5729.0 5733.7 5864.0 5707.3 5748.0 5755.6 5777.1 5790.2 6132.6 6156.6 6199.4 6228.4 6337.1 6632.8 6656.8 6677.9 6702.2 6704.0 6852.0 6854.3 6895.6 6898.5 6908.5 6214.8 6243.8 6261.5 6302.6 6309.9 6687.2 6911.4 6976.1 6980.8 6994.1 6423.1 6423.7 6428.0 6461.1 6475.9 6446.3 6563.3 6643.8 6727.7 6750.9 6621.8 6702.2 6724.9 6782.2 6799.0 6714.2 6726.3 6770.9 6775.6 6823.1 5151.3 5232.9 5274.4 5340.8 5356.1 4566.1 4569.9 4612.6 4642.0 4659.6 5738.9 5794.9 5802.7 5807.9 5848.0 6702.5 6708.1 6800.7 6800.7 6804.2 5710.3 5816.2 5817.9 5854.7 5856.3 5668.0 5669.5 5705.8 5751.2 5761.1 6503.7 6541.2 6567.7 6595.7 6613.3 6771.5 6778.7 6843.8 6877.6 6899.8 6498.2 6501.0 6504.3 6531.6 6577.7 6482.6 6586.1 6589.9 6720.7 6789.6 6663.2 6743.8 6759.5 6759.8 6761.0 6510.9 6544.1 6578.2 6629.9 6630.5 6503.0 6521.7 6528.0 6592.4 6613.6 6427.2 6432.3 6513.1 6514.3 6514.7 6387.2 6441.2 6526.0 6547.3 6558.7 6343.0 6409.8 6418.1 6425.8 6441.3 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | [#1] ext.html Cycles:180 Average:37704.94 Median:3576.88 stddev:54118.27 (1513.0%) stddev-sans-first:54199.44 03:55:27 INFO - PID 1611 | Values: 878.4 901.9 902.5 904.9 906.2 39112.2 39940.4 42922.1 43012.0 43175.0 39810.6 40065.6 40083.8 40125.2 40233.8 7172.1 7269.9 7328.1 7362.3 7387.9 7748.6 7953.2 7967.6 7976.9 8020.4 7991.0 8058.5 8062.2 8070.3 8073.9 7948.5 7978.9 8041.9 8181.0 8194.3 7897.1 7903.4 7985.8 7998.7 8001.1 37658.0 38216.8 38218.6 38325.8 38412.0 3515.2 3541.4 3554.7 3557.5 3596.3 31716.5 31734.0 31768.0 31935.2 32014.4 5156.7 5164.1 5174.1 5199.6 5247.8 193130.0 193785.0 194775.0 195111.0 195757.0 41378.2 42052.4 48315.0 48721.5 48741.8 44872.0 52262.7 52961.5 53131.7 53319.2 16231.8 16579.8 16648.8 16728.6 16743.1 13496.6 13514.5 13544.1 13571.0 13595.8 14688.2 14692.8 14752.2 14857.2 14864.0 5759.0 5777.7 5910.7 5933.7 5979.9 986.9 990.2 991.8 1000.7 1001.2 22368.0 22624.0 22651.9 22735.3 22885.4 1080.1 1082.3 1091.3 1096.7 1116.7 12036.9 12140.2 12151.8 12176.1 12187.9 231125.0 231248.0 231546.0 231627.0 232678.0 53543.5 53638.0 53650.7 54117.7 54195.7 1413.7 1449.9 1450.1 1475.5 1484.8 21646.0 22429.2 22463.4 22620.9 22874.1 37888.8 38055.0 38278.2 38319.2 38353.2 198309.0 198493.0 198497.0 199351.0 199704.0 31656.7 32454.7 32506.5 32612.3 34765.0 38956.8 42264.8 42803.6 44476.6 44721.8 32084.0 32184.2 32582.8 32722.7 32761.0 31207.1 31367.7 31571.2 31582.0 31928.0 36226.5 36477.1 36585.5 36635.5 36755.8 30903.5 31669.8 31861.2 31946.0 32321.4 22944.9 22996.8 23127.4 23566.2 23903.4 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | [#2] jquery.html Cycles:180 Average:33178.64 Median:22718.55 stddev:75664.62 (333.1%) stddev-sans-first:75837.26 03:55:27 INFO - PID 1611 | Values: 567.3 571.9 585.9 590.3 613.7 21634.4 22482.0 22542.0 22792.9 22810.0 22469.9 22644.2 24546.9 24895.8 25140.6 6428.7 6572.4 6618.1 6631.4 6635.1 6509.9 6614.2 6630.1 6634.0 6634.1 6334.2 6533.6 6634.8 6635.6 6642.7 6509.9 6577.6 6578.7 6620.3 6622.5 5973.5 6120.5 6177.1 6191.5 6203.4 27314.3 27919.0 27975.0 27982.7 28038.2 2003.2 2032.6 2042.6 2049.7 2055.0 18558.5 18766.0 19115.3 19287.9 19289.0 2379.5 2454.3 2463.3 2469.7 2474.8 113949.0 117064.4 118411.0 118941.0 136473.0 14639.6 14931.6 14980.6 15000.2 15110.8 23738.2 23779.9 23780.8 23834.4 23862.3 10039.3 10180.6 10208.9 10307.2 10371.3 9533.0 9704.7 9740.7 9749.6 9783.3 8922.5 8928.0 9064.0 9082.1 9293.1 2713.2 2741.3 2789.5 2821.2 2835.4 912.1 920.6 941.0 952.4 960.9 18227.7 19096.4 19100.9 19150.9 19610.8 1010.2 1020.8 1023.4 1023.8 1024.1 10385.2 10488.9 10707.3 10725.5 10788.5 439194.0 447985.0 448401.0 453191.0 453254.0 114941.0 116049.4 116428.4 116486.4 117170.0 1016.5 1125.4 1143.9 1158.5 1181.2 20301.6 20334.9 20429.9 20663.1 20821.0 57143.0 57964.7 58538.7 59210.7 59809.4 69260.3 71761.6 72836.6 73360.3 73822.3 14452.6 14575.9 14712.8 14736.7 14773.5 22636.3 22832.5 23093.9 23178.8 23225.2 17872.4 18080.1 18304.8 18421.8 18498.1 15692.0 16163.3 16192.5 16688.0 16967.0 18801.5 18819.9 18939.9 19123.9 19151.4 13521.1 14356.9 14445.2 14488.7 14509.2 17824.7 18151.7 18189.9 18192.7 18356.0 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | [#3] mootools.html Cycles:180 Average:9246.61 Median:2652.32 stddev:6430.21 (242.4%) stddev-sans-first:6420.66 03:55:27 INFO - PID 1611 | Values: 1318.4 1370.3 1372.0 1377.1 1377.8 14293.5 15057.6 15144.9 15152.2 15178.2 14705.6 14808.9 14825.0 14862.3 14885.1 2654.5 2746.2 2752.2 2772.9 2774.2 2740.7 2815.5 2822.5 2826.1 2828.3 2731.8 2769.1 2776.8 2779.8 2782.1 2630.1 2641.5 2661.9 2676.5 2679.1 2620.0 2650.2 2661.5 2665.9 2669.7 14094.8 14349.4 14355.8 14385.1 14441.4 7712.9 8007.8 8097.9 8104.5 8118.8 5204.4 5406.9 5497.5 5539.5 5628.3 1894.2 1909.2 1944.1 1946.9 1951.6 22409.7 23129.5 24661.4 25276.7 25404.5 7215.4 7296.3 7334.9 7436.0 7486.6 19685.7 19730.2 19742.0 19745.2 19747.7 8168.3 8216.2 8216.3 8299.4 8304.0 7106.4 7429.0 7432.3 7466.4 7547.4 5504.6 5508.5 5657.6 5665.8 5898.0 1691.4 1733.5 1735.3 1753.3 1754.4 881.1 894.9 895.4 899.8 912.7 8223.0 8439.5 8462.9 8498.4 8583.1 689.3 733.3 739.1 739.4 740.0 4554.3 4596.2 4609.7 4737.2 4748.6 20258.1 21301.0 21320.3 21348.6 21394.8 20098.0 20375.2 20466.0 20511.2 20665.9 9345.0 9749.8 9985.5 10905.7 11171.8 8295.2 8579.4 8620.2 8716.1 8817.2 17248.3 18103.7 18299.6 18499.3 18512.6 17857.2 18204.8 18216.1 18236.7 19462.5 11777.7 12044.1 12070.0 12152.5 12255.7 13371.7 13693.5 13696.7 13698.7 13715.9 10856.1 10867.7 11082.2 11121.6 11126.8 10256.3 10338.6 10538.0 10879.8 10883.1 10097.6 10133.0 10195.6 10197.4 10258.6 7231.7 7315.2 7372.2 7409.8 7430.0 7503.1 7640.2 7709.4 7734.8 7751.4 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | [#4] prototype.html Cycles:180 Average:5415.82 Median:6024.78 stddev:1491.99 (24.8%) stddev-sans-first:1449.99 03:55:27 INFO - PID 1611 | Values: 508.6 525.2 536.6 542.4 544.6 6069.7 6142.4 6152.4 6183.6 6215.8 6024.6 6044.4 6052.4 6092.5 6104.0 5128.2 5140.5 5143.2 5187.9 5188.8 5092.6 5101.9 5135.9 5155.0 5170.9 4722.5 4934.7 4952.7 4959.4 5082.6 4917.2 4943.8 4954.6 4956.9 4973.2 4435.3 4443.2 4457.0 4475.3 4514.3 5890.0 5936.8 5991.2 5993.2 6024.9 5628.0 5631.7 5639.9 5660.7 5664.3 6407.9 6411.6 6479.5 6506.5 6536.2 4633.1 4773.7 4842.4 4851.0 4909.2 6556.8 6642.3 6670.9 6679.7 6696.4 4968.4 4980.0 4991.6 5014.1 5024.8 5071.2 5074.7 5082.7 5100.2 5105.1 5564.8 5566.7 5620.8 5624.7 5663.0 6507.6 6530.2 6533.3 6543.0 6555.7 1744.1 1751.0 1754.3 1758.3 1758.4 1147.6 1232.2 1234.9 1235.4 1243.5 5531.3 5545.7 5573.2 5577.1 5644.5 6487.5 6493.6 6537.5 6548.6 6562.5 5539.6 5594.9 5599.4 5617.9 5632.2 3400.5 3409.6 3419.9 3441.9 3472.7 6295.0 6315.1 6369.6 6371.0 6429.3 6608.0 6615.3 6661.6 6699.9 6721.1 5879.1 6252.6 6253.2 6357.9 6391.9 6406.3 6442.8 6503.4 6565.9 6576.0 6487.4 6518.0 6581.0 6597.4 6606.8 6249.3 6301.4 6347.5 6442.6 6460.9 4794.5 4947.9 4960.5 4967.8 4973.6 6318.9 6431.5 6483.9 6513.9 6563.9 6223.8 6293.9 6316.8 6339.9 6390.4 6339.6 6355.8 6366.4 6399.6 6444.5 6290.7 6296.1 6304.4 6329.7 6357.3 6346.5 6396.3 6417.4 6453.2 6494.2 6210.8 6231.9 6249.2 6265.5 6293.6 03:55:27 INFO - PID 1611 | 03:55:27 INFO - PID 1611 | [#5] yui.html Cycles:180 Average:25089.06 Median:18732.53 stddev:36699.02 (195.9%) stddev-sans-first:36756.96 03:55:27 INFO - PID 1611 | Values: 882.8 906.1 909.0 921.5 930.9 17367.6 17872.0 17878.2 17908.2 17918.2 18720.4 18744.6 18964.7 19178.6 19321.5 939.1 968.9 971.2 972.3 973.1 974.6 986.7 992.1 994.3 997.0 976.3 1008.7 1010.5 1012.2 1013.6 993.4 993.6 999.3 1000.8 1006.8 719.8 738.8 746.9 749.7 752.3 19390.1 19462.4 19627.5 19641.1 19641.4 21435.9 21681.0 22101.6 22170.1 22411.1 17427.2 17603.5 17766.0 17894.6 18180.1 3696.3 3781.7 3782.6 3782.8 3785.5 136299.0 137459.0 138565.3 138738.0 142805.0 16664.8 16904.0 16932.7 17175.7 17286.5 30847.2 31421.4 31439.2 31892.5 32302.8 9027.0 9085.9 9139.3 9145.8 9170.1 4175.0 4273.2 4335.7 4378.2 4394.0 5539.6 5625.2 5663.0 5668.3 5687.2 1007.0 1029.5 1048.2 1051.4 1054.4 657.0 670.1 674.7 677.6 697.1 11007.5 11366.5 11752.6 12271.3 12289.0 618.3 619.6 622.2 631.5 644.8 5514.6 5572.2 5578.6 5652.3 5762.9 124463.2 127159.0 129182.0 129246.0 132426.0 113136.4 115905.0 116821.4 117422.0 118802.4 95860.5 101524.0 101960.0 102520.0 104292.0 10188.6 10300.8 10411.8 10656.6 10822.7 45275.3 46218.0 46938.0 47399.8 47604.0 60655.4 61666.7 62995.0 63156.0 63362.0 15398.9 15420.8 15661.8 15691.7 15801.8 17036.8 17343.4 17368.3 17477.3 17787.6 16178.4 16266.0 16381.4 16419.8 16660.8 16162.4 16356.7 16450.2 16579.5 16597.8 15859.4 15955.8 16140.0 16149.2 16470.3 11620.5 11782.8 11862.1 11940.7 11942.8 12055.3 12120.8 12151.5 12395.0 12481.6 03:55:27 INFO - PID 1611 | -------- Summary: end -------- 03:55:27 INFO - PID 1611 | 03:55:28 INFO - TEST-INFO | 1611: exit 0 03:55:28 INFO - TEST-OK | dromaeo_css | took 1114054ms 03:55:28 INFO - TEST-START | kraken 03:55:28 INFO - Initialising browser for kraken test... 03:55:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41001/getInfo.html -profile /tmp/tmpcsGH8D/profile 03:55:28 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/firefox/firefox http://localhost:41001/getInfo.html) 03:55:34 INFO - TEST-INFO | 1985: exit 0 03:55:34 INFO - Browser initialized. 03:55:34 INFO - Running cycle 1/1 for kraken test... 03:55:35 INFO - Using env: {'DISPLAY': ':0', 03:55:35 INFO - 'HOME': '/home/cltbld', 03:55:35 INFO - 'JSGC_DISABLE_POISONING': '1', 03:55:35 INFO - 'LANG': 'en_US.UTF-8', 03:55:35 INFO - 'LANGUAGE': 'en_US:en', 03:55:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:55:35 INFO - 'LOGNAME': 'cltbld', 03:55:35 INFO - 'MAIL': '/var/mail/cltbld', 03:55:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:55:35 INFO - 'MOZ_ACCELERATED': '1', 03:55:35 INFO - 'MOZ_CRASHREPORTER': '1', 03:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:55:35 INFO - 'MOZ_NO_REMOTE': '1', 03:55:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:35 INFO - 'MOZ_WEBRENDER': '1', 03:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:35 INFO - 'NO_EM_RESTART': '1', 03:55:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:35 INFO - 'PWD': '/builds/slave/test', 03:55:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:35 INFO - 'RUST_BACKTRACE': 'full', 03:55:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:55:35 INFO - 'SHELL': '/bin/bash', 03:55:35 INFO - 'SHLVL': '1', 03:55:35 INFO - 'TERM': 'linux', 03:55:35 INFO - 'TMOUT': '86400', 03:55:35 INFO - 'USER': 'cltbld', 03:55:35 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793', 03:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:35 INFO - '_': '/tools/buildbot/bin/python'} 03:55:35 INFO - TEST-INFO | started process 2232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcsGH8D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:35 INFO - PID 2232 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:55:36 INFO - PID 2232 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:55:36 INFO - PID 2232 | 03:55:36 INFO - PID 2232 | (/builds/slave/test/build/application/firefox/firefox:2292): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:55:36 INFO - PID 2232 | 03:55:46 INFO - PID 2232 | RSS: Main: 207040512 03:55:46 INFO - PID 2232 | 03:55:49 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-beat-detection) 03:55:50 INFO - PID 2232 | RSS: Main: 204558336 03:55:50 INFO - PID 2232 | 03:55:53 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-dft) 03:55:53 INFO - PID 2232 | RSS: Main: 205553664 03:55:53 INFO - PID 2232 | 03:55:56 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-fft) 03:55:57 INFO - PID 2232 | RSS: Main: 201928704 03:55:57 INFO - PID 2232 | 03:55:59 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41001/tests/kraken/driver.html?testName=audio-oscillator) 03:56:00 INFO - PID 2232 | RSS: Main: 201621504 03:56:00 INFO - PID 2232 | 03:56:02 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:02 INFO - PID 2232 | RSS: Main: 201736192 03:56:02 INFO - PID 2232 | 03:56:06 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41001/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:06 INFO - PID 2232 | RSS: Main: 203776000 03:56:06 INFO - PID 2232 | 03:56:10 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41001/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:11 INFO - PID 2232 | RSS: Main: 203915264 03:56:11 INFO - PID 2232 | 03:56:14 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41001/tests/kraken/driver.html?testName=json-parse-financial) 03:56:14 INFO - PID 2232 | RSS: Main: 204820480 03:56:14 INFO - PID 2232 | 03:56:16 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:16 INFO - PID 2232 | RSS: Main: 204767232 03:56:16 INFO - PID 2232 | 03:56:18 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:19 INFO - PID 2232 | RSS: Main: 204734464 03:56:19 INFO - PID 2232 | 03:56:21 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:22 INFO - PID 2232 | RSS: Main: 204750848 03:56:22 INFO - PID 2232 | 03:56:24 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:25 INFO - PID 2232 | RSS: Main: 205262848 03:56:25 INFO - PID 2232 | 03:56:28 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:28 INFO - PID 2232 | RSS: Main: 205131776 03:56:28 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | Cycle 1(1): loaded http://localhost:41001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41001/tests/kraken/driver.html?testName=ai-astar) 03:56:30 INFO - PID 2232 | RSS: Main: 206303232 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | __start_tp_report 03:56:30 INFO - PID 2232 | _x_x_mozilla_page_load 03:56:30 INFO - PID 2232 | _x_x_mozilla_page_load_details 03:56:30 INFO - PID 2232 | |i|pagename|runs| 03:56:30 INFO - PID 2232 | |0;ai-astar;119;107;106;114;113;115;115;109;115;118 03:56:30 INFO - PID 2232 | |1;audio-beat-detection;122;121;118;145;127;127;116;120;115;121 03:56:30 INFO - PID 2232 | |2;audio-dft;163;171;175;170;168;164;163;174;165;163 03:56:30 INFO - PID 2232 | |3;audio-fft;80;77;74;81;75;75;80;76;77;81 03:56:30 INFO - PID 2232 | |4;audio-oscillator;80;85;83;82;81;85;84;87;81;81 03:56:30 INFO - PID 2232 | |5;imaging-gaussian-blur;112;115;114;111;121;113;115;115;112;116 03:56:30 INFO - PID 2232 | |6;imaging-darkroom;147;150;155;160;156;147;152;151;149;158 03:56:30 INFO - PID 2232 | |7;imaging-desaturate;94;96;102;95;93;96;96;95;103;100 03:56:30 INFO - PID 2232 | |8;json-parse-financial;52;64;51;51;54;55;50;51;52;52 03:56:30 INFO - PID 2232 | |9;json-stringify-tinderbox;42;47;42;44;47;46;47;37;44;40 03:56:30 INFO - PID 2232 | |10;stanford-crypto-aes;78;74;76;76;75;73;76;73;74;73 03:56:30 INFO - PID 2232 | |11;stanford-crypto-ccm;113;110;126;124;118;113;127;110;109;113 03:56:30 INFO - PID 2232 | |12;stanford-crypto-pbkdf2;162;163;171;163;164;169;162;163;160;173 03:56:30 INFO - PID 2232 | |13;stanford-crypto-sha256-iterative;63;64;67;63;79;67;61;64;64;63 03:56:30 INFO - PID 2232 | __end_tp_report 03:56:30 INFO - PID 2232 | __start_cc_report 03:56:30 INFO - PID 2232 | _x_x_mozilla_cycle_collect,761 03:56:30 INFO - PID 2232 | __end_cc_report 03:56:30 INFO - PID 2232 | __startTimestamp1506855390918__endTimestamp 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | ------- Summary: start ------- 03:56:30 INFO - PID 2232 | Number of tests: 14 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:4.41 (3.8%) stddev-sans-first:4.13 03:56:30 INFO - PID 2232 | Values: 119.0 107.0 106.0 114.0 113.0 115.0 115.0 109.0 115.0 118.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:121.50 stddev:8.64 (7.1%) stddev-sans-first:9.15 03:56:30 INFO - PID 2232 | Values: 122.0 121.0 118.0 145.0 127.0 127.0 116.0 120.0 115.0 121.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#2] audio-dft Cycles:10 Average:167.60 Median:169.00 stddev:4.67 (2.8%) stddev-sans-first:4.65 03:56:30 INFO - PID 2232 | Values: 163.0 171.0 175.0 170.0 168.0 164.0 163.0 174.0 165.0 163.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#3] audio-fft Cycles:10 Average:77.60 Median:78.50 stddev:2.67 (3.4%) stddev-sans-first:2.69 03:56:30 INFO - PID 2232 | Values: 80.0 77.0 74.0 81.0 75.0 75.0 80.0 76.0 77.0 81.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:83.50 stddev:2.28 (2.7%) stddev-sans-first:2.17 03:56:30 INFO - PID 2232 | Values: 80.0 85.0 83.0 82.0 81.0 85.0 84.0 87.0 81.0 81.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:115.00 stddev:2.84 (2.5%) stddev-sans-first:2.87 03:56:30 INFO - PID 2232 | Values: 112.0 115.0 114.0 111.0 121.0 113.0 115.0 115.0 112.0 116.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#6] imaging-darkroom Cycles:10 Average:152.50 Median:153.50 stddev:4.55 (3.0%) stddev-sans-first:4.37 03:56:30 INFO - PID 2232 | Values: 147.0 150.0 155.0 160.0 156.0 147.0 152.0 151.0 149.0 158.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:95.00 stddev:3.43 (3.6%) stddev-sans-first:3.46 03:56:30 INFO - PID 2232 | Values: 94.0 96.0 102.0 95.0 93.0 96.0 96.0 95.0 103.0 100.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:52.00 stddev:4.08 (7.8%) stddev-sans-first:4.30 03:56:30 INFO - PID 2232 | Values: 52.0 64.0 51.0 51.0 54.0 55.0 50.0 51.0 52.0 52.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#9] json-stringify-tinderbox Cycles:10 Average:43.60 Median:45.00 stddev:3.37 (7.5%) stddev-sans-first:3.53 03:56:30 INFO - PID 2232 | Values: 42.0 47.0 42.0 44.0 47.0 46.0 47.0 37.0 44.0 40.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.50 stddev:1.69 (2.2%) stddev-sans-first:1.33 03:56:30 INFO - PID 2232 | Values: 78.0 74.0 76.0 76.0 75.0 73.0 76.0 73.0 74.0 73.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:115.50 stddev:6.96 (6.0%) stddev-sans-first:7.28 03:56:30 INFO - PID 2232 | Values: 113.0 110.0 126.0 124.0 118.0 113.0 127.0 110.0 109.0 113.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:163.50 stddev:4.37 (2.7%) stddev-sans-first:4.50 03:56:30 INFO - PID 2232 | Values: 162.0 163.0 171.0 163.0 164.0 169.0 162.0 163.0 160.0 173.0 03:56:30 INFO - PID 2232 | 03:56:30 INFO - PID 2232 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:64.00 stddev:5.08 (7.9%) stddev-sans-first:5.31 03:56:30 INFO - PID 2232 | Values: 63.0 64.0 67.0 63.0 79.0 67.0 61.0 64.0 64.0 63.0 03:56:30 INFO - PID 2232 | -------- Summary: end -------- 03:56:30 INFO - PID 2232 | 03:56:31 INFO - PID 2232 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:56:32 INFO - TEST-INFO | 2232: exit 0 03:56:32 INFO - TEST-OK | kraken | took 63362ms 03:56:32 INFO - SUITE-END | took 1177s 03:56:32 INFO - Completed test suite (00:19:37) 03:56:32 INFO - javascript benchmark 03:56:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8488.4478248343, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.142981395022, 3192.1381227068678, 3192.888248911288, 3202.151429871083, 3212.1166679163234, 6197.380261973801, 6239.844003899905, 6275.5920865143735, 6277.654728989904, 6329.651869147195, 6151.630902145863, 6168.290646575645, 6210.596311239767, 6229.159063526423, 6237.875242495147, 5618.747156377953, 5696.401877802833, 5698.458646428583, 5709.1150871614755, 5721.485066344028, 5751.309842818868, 5787.884242315151, 5826.708664566776, 5829.7376618052285, 5855.736491857855, 5826.708664566755, 5832.445917637818, 5874.765009399619, 5904.822855314347, 5915.349311575723, 5590.580706447033, 5722.170285308649, 5728.971355143198, 5733.684647344395, 5864.032434648278, 5707.286589176353, 5748.0, 5755.597108202427, 5777.133429985493, 5790.160426738099, 6132.6013809102715, 6156.630602163839, 6199.380061993809, 6228.4394404503355, 6337.112804207414, 6632.801015969529, 6656.83357916056, 6677.866442671119, 6702.162229721285, 6703.966480167568, 6851.9657401713175, 6854.280300568418, 6895.586264824076, 6898.517103802736, 6908.516403851732, 6214.8135555933395, 6243.812685619393, 6261.467775239064, 6302.590331628429, 6309.936900630981, 6687.164104486939, 6911.447084233249, 6976.058232138596, 6980.755673551402, 6994.090768200102, 6423.068655044993, 6423.678816059271, 6427.967860160669, 6461.06314584392, 6475.870482590321, 6446.258680251831, 6563.310852360529, 6643.800685979331, 6727.730890764413, 6750.864982700318, 6621.808074546531, 6702.19573651165, 6724.865502689919, 6782.220044694924, 6799.014142949343, 6714.160729908762, 6726.260111387744, 6770.898436523456, 6775.627340496221, 6823.078884350549, 5151.2530683050745, 5232.92150617741, 5274.446183150714, 5340.759665815048, 5356.062689029404, 4566.109608626286, 4569.9314510282375, 4612.584867361954, 4641.976790116028, 4659.603933665677, 5738.856528586819, 5794.913076303858, 5802.709864506758, 5807.8548036299435, 5848.0350742127075, 6702.497312701469, 6708.094407255056, 6800.6939687714175, 6800.727970881208, 6804.183497980175, 5710.314762228476, 5816.1566572846705, 5817.94182058174, 5854.736536855852, 5856.326522449887, 5667.971660141756, 5669.461401166883, 5705.828825135252, 5751.223584815996, 5761.135829625506, 6503.739850406026, 6541.247756508063, 6567.737290508422, 6595.70319335631, 6613.3056029117215, 6771.492138089663, 6778.694958726771, 6843.794686159423, 6877.58734475913, 6899.827504312432, 6498.155239818793, 6501.0, 6504.284528701934, 6531.640759758259, 6577.736890524326, 6482.611043337415, 6586.1438013058, 6589.901151482636, 6720.697568609522, 6789.626570538668, 6663.167104111986, 6743.797686069426, 6759.526833121831, 6759.763408280686, 6760.9520524318805, 6510.869782604226, 6544.083828263952, 6578.210614726264, 6629.933700662931, 6630.469562434897, 6503.02454631809, 6521.739130434729, 6527.9673601633585, 6592.406683398517, 6613.636250006296, 6427.164468619237, 6432.292447830641, 6513.088167656437, 6514.2834288229205, 6514.706838192387, 6387.233531976192, 6441.1626488556185, 6526.0, 6547.345265473415, 6558.737650494118, 6343.0485427186295, 6409.775657851953, 6418.133551970611, 6425.839354016, 6441.323661015525], "value": 6119.40340108367, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.367575345751, 901.8511945528988, 902.467544148952, 904.8597467392548, 906.1799071839985, 39112.2177556449, 39940.40089398661, 42922.14155716884, 43012.0, 43175.0, 39810.60189398105, 40065.59934400655, 40083.79958100205, 40125.19749605006, 40233.79883100588, 7172.139343278801, 7269.927300727004, 7328.083989501312, 7362.263773622622, 7387.852242955138, 7748.573828439462, 7953.244441778022, 7967.601619918981, 7976.880346794803, 8020.438569300151, 7990.960045199795, 8058.516489010678, 8062.153473885245, 8070.273675369215, 8073.919260807375, 7948.523088614702, 7978.9202107979045, 8041.919580804176, 8181.0, 8194.30348420385, 7897.091834439056, 7903.36773058154, 7985.800354991114, 7998.680052797881, 8001.079875814297, 37658.0, 38216.80891595524, 38218.61781382179, 38325.80837095824, 38412.0, 3515.1739341254784, 3541.38025845476, 3554.680078792921, 3557.484164796116, 3596.28074385124, 31716.524252136238, 31734.04797856068, 31768.0, 31935.201619959455, 32014.359712805846, 5156.716380599066, 5164.122099243138, 5174.09453345663, 5199.610029247821, 5247.842564723064, 193130.0, 193785.0, 194775.0, 195110.99999999857, 195757.02121489443, 41378.1724365511, 42052.36921446181, 48315.0, 48721.512784871695, 48741.75629121832, 44872.0, 52262.73868630632, 52961.47038529642, 53131.73434132805, 53319.20021199685, 16231.756523652155, 16579.751303730452, 16648.75026874598, 16728.58178545522, 16743.07913064793, 13496.595102146952, 13514.526991555249, 13544.051916365957, 13571.0, 13595.796063059062, 14688.192149431883, 14692.779608305884, 14752.18862962526, 14857.182854942866, 14864.0, 5759.0, 5777.653340799481, 5910.704464776744, 5933.703314834241, 5979.940200597938, 986.8519722041608, 990.1732053735068, 991.7966816802539, 1000.7097941597001, 1001.2140469731372, 22368.0, 22624.0, 22651.88674056619, 22735.317940461813, 22885.427864303194, 1080.103514083309, 1082.3181395720803, 1091.2743025887855, 1096.6929259807266, 1116.6594188772503, 12036.939815300868, 12140.15018948665, 12151.756964860653, 12176.086793490524, 12187.878121218851, 231125.0, 231248.0, 231546.0, 231627.0, 232678.0, 53543.46456535385, 53638.0, 53650.73174634102, 54117.72941135348, 54195.729021354644, 1413.6607214268706, 1449.8622630850052, 1450.0574626492653, 1475.4835807467516, 1484.7624380099132, 21646.0, 22429.21497747571, 22463.438414039127, 22620.886895565418, 22874.085036599015, 37888.81055594815, 38055.0, 38278.23443531058, 38319.23361532809, 38353.23293534169, 198309.0, 198493.0, 198497.0, 199351.0, 199704.0, 31656.67604901452, 32454.675453245167, 32506.51240231351, 32612.34775304528, 34765.0, 38956.80521597374, 42264.78867605642, 42803.57196427996, 44476.55523444724, 44721.776391119136, 32084.0, 32184.19539511531, 32582.83708581442, 32722.672773272916, 32761.0, 31207.063788086394, 31367.68632313739, 31571.210719731273, 31582.0, 31928.0, 36226.4566031515, 36477.08807279839, 36585.45121823122, 36635.45046824247, 36755.81622091872, 30903.536446953764, 31669.841650791597, 31861.20346991344, 31946.0, 32321.35357292794, 22944.885275573517, 22996.770032299464, 23127.4218144541, 23566.175183869167, 23903.402414939766], "value": 17230.67512958508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.347550317135, 571.9370869204389, 585.8564651660341, 590.309338074453, 613.7238242790745, 21634.350969470903, 22482.0, 22542.0, 22792.88603556982, 22810.0, 22469.887650561766, 22644.207452739156, 24546.877265613646, 24895.75104248957, 25140.62289065661, 6428.742850285983, 6572.408483236508, 6618.073469714244, 6631.403173714365, 6635.104260924762, 6509.9023514647315, 6614.173228346457, 6630.138082049327, 6634.004899265101, 6634.0712300278, 6334.208223972004, 6533.640649764261, 6634.767783127591, 6635.601863888158, 6642.701078451457, 6509.869802603968, 6577.6053436793945, 6578.703958321863, 6620.271770105284, 6622.503312251552, 5973.492253158487, 6120.540959428016, 6177.135201071854, 6191.473724733403, 6203.4416902479, 27314.31714207141, 27919.0, 27975.0, 27982.720172798417, 28038.158855234375, 2003.2387692676834, 2032.6442872497403, 2042.6425375559365, 2049.692546118094, 2055.0341339570377, 18558.536036599195, 18766.0, 19115.330963416214, 19287.903560482107, 19289.03554822253, 2379.512199998996, 2454.349597356702, 2463.322586288767, 2469.740677228901, 2474.8020158387285, 113949.0, 117064.41467792606, 118410.99999999914, 118941.0, 136473.0, 14639.560813175622, 14931.626709332353, 14980.631073043696, 15000.174990375415, 15110.848891510945, 23738.169164079176, 23779.881100594386, 23780.762192377853, 23834.404139896295, 23862.284131476084, 10039.297249192487, 10180.592776288866, 10208.897911020944, 10307.175425965905, 10371.274010819321, 9532.95233523828, 9704.70885873425, 9740.707778766648, 9749.561269742879, 9783.315167938319, 8922.464652120894, 8927.955360223157, 9063.957644870792, 9082.091790820865, 9293.117153870371, 2713.213168181245, 2741.3420779012895, 2789.470000699901, 2821.195959151673, 2835.376217232206, 912.0924679943498, 920.6087412849512, 940.9576569054409, 952.3761935931975, 960.9423434593947, 18227.72658410125, 19096.427107186806, 19100.904495477433, 19150.904245478963, 19610.803891961183, 1010.1565193063874, 1020.7856350166549, 1023.4268809466722, 1023.8157131716214, 1024.1243736605245, 10385.169186465064, 10488.895111048945, 10707.250492465453, 10725.51735171919, 10788.51451684676, 439194.0, 447985.0, 448401.0, 453191.0, 453254.0, 114941.0, 116049.41975290238, 116428.41785791186, 116486.41756791332, 117170.0, 1016.5425558498705, 1125.352922069813, 1143.8856114388495, 1158.4555259028243, 1181.208590244521, 20301.59396812085, 20334.89832550828, 20429.897850510653, 20663.070161842454, 20821.0, 57143.0, 57964.71017644885, 58538.7073064632, 59210.70394647999, 59809.40190598038, 69260.30739692539, 71761.64119179579, 72836.63581682058, 73360.26639733747, 73822.26177738154, 14452.638684032563, 14575.927120364331, 14712.779308310597, 14736.705265894409, 14773.482928097465, 22636.320910372717, 22832.543349133255, 23093.88453057724, 23178.768212318337, 23225.187118450773, 17872.374466893598, 18080.095995199925, 18304.81695183031, 18421.81578184201, 18498.075096244866, 15692.038495188102, 16163.272652730891, 16192.514224573282, 16688.0, 16967.0, 18801.529961751065, 18819.90590047041, 18939.90530047341, 19123.90438047801, 19151.425457236306, 13521.121127126706, 14356.928215358856, 14445.205513696848, 14488.710225795636, 14509.201993890438, 17824.732629010316, 18151.727724083885, 18189.909050454662, 18192.727109093637, 18356.0], "value": 11883.60604336195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.3803612302218, 1370.2874505257273, 1372.0464277327255, 1377.1255252914402, 1377.8415482219546, 14293.49972750954, 15057.62355941102, 15144.924275378635, 15152.242387880604, 15178.165200913945, 14705.632359190999, 14808.925955370236, 14825.0, 14862.33119509622, 14885.106893586393, 2654.4558365535117, 2746.1624204617583, 2752.174347695693, 2772.8613569321556, 2774.1954833098375, 2740.6985231624503, 2815.4650616382924, 2822.463731890934, 2826.0956493921954, 2828.321202911297, 2731.754142127208, 2769.0862015534826, 2776.7778577713834, 2779.791515636325, 2782.095818858869, 2630.053180854891, 2641.4981153580757, 2661.9334516637045, 2676.464707058596, 2679.1426743442107, 2619.973800261992, 2650.178444682155, 2661.507621090085, 2665.9333516662045, 2669.6796384433796, 14094.788578171336, 14349.354279057363, 14355.78466323006, 14385.064970776866, 14441.35013924376, 7712.922870771276, 8007.839843203162, 8097.878531822027, 8104.47320924144, 8118.75643730689, 5204.401493828221, 5406.91889621656, 5497.532709719679, 5539.501444869981, 5628.296462942132, 1894.2233684189555, 1909.1981367825547, 1944.0862794486568, 1946.8929208893505, 1951.5706544560173, 22409.66385504219, 23129.53740925172, 24661.383465413328, 25276.747232527807, 25404.49191016188, 7215.422766178693, 7296.306850849161, 7334.853302933911, 7436.0, 7486.5508069516, 19685.704714429296, 19730.210791568177, 19742.012899354973, 19745.210191592174, 19747.703784443245, 8168.264856162974, 8216.21945915137, 8216.34269258458, 8299.377546684023, 8304.045034820952, 7106.360427561544, 7429.034225550644, 7432.256774322633, 7466.402687784964, 7547.358474529617, 5504.614676972654, 5508.504234618904, 5657.6039677223025, 5665.830025099253, 5898.0, 1691.4249155287262, 1733.54927718794, 1735.3318972195543, 1753.2636292757072, 1754.4385796544982, 881.0660699658382, 894.8612964990436, 895.4224525181222, 899.7705585075895, 912.6896855069308, 8223.0, 8439.535825529532, 8462.89982302309, 8498.447600905922, 8583.098774628574, 689.2659317826499, 733.2667332667332, 739.1241378965835, 739.3567596191348, 740.034255296832, 4554.339620754972, 4596.17268891596, 4609.700369475973, 4737.2183589708, 4748.596369308648, 20258.08838602237, 21301.0, 21320.253791117237, 21348.573028539344, 21394.78605213928, 20097.99510024493, 20375.184992600425, 20466.0, 20511.17955281802, 20665.896670516853, 9344.999999999864, 9749.756256093655, 9985.450800205914, 10905.727356816144, 11171.776564468828, 8295.211954864279, 8579.442336248374, 8620.224179823595, 8716.084811094745, 8817.206451419403, 17248.310067597657, 18103.728444073087, 18299.634007320044, 18499.260029599205, 18512.629747405244, 17857.196426161114, 18204.81795182031, 18216.089195540437, 18236.726449103007, 19462.513437164183, 11777.705557360792, 12044.096692748255, 12070.0, 12152.453139608562, 12255.69360765988, 13371.729685679846, 13693.452261909411, 13696.726065478833, 13698.726025479635, 13715.931420342835, 10856.131509479064, 10867.673969780919, 11082.22424430282, 11121.555137794398, 11126.833097503706, 10256.282060255711, 10338.638147664795, 10538.0, 10879.782404352027, 10883.129349652167, 10097.646582369582, 10133.0, 10195.592176313161, 10197.439140847027, 10258.589656413958, 7231.746888858865, 7315.231900650355, 7372.225916278713, 7409.777706668809, 7429.962850185714, 7503.137139229058, 7640.197779233323, 7709.383249339927, 7734.7679569613, 7751.37988960893], "value": 6646.513497266623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.56263613292583, 525.1964494323685, 536.5841472858534, 542.3708498142156, 544.5752313195707, 6069.696515174241, 6142.385761423855, 6152.4462798348195, 6183.567150299481, 6215.844603884905, 6024.644454997623, 6044.425779550936, 6052.425019623129, 6092.451679348857, 6104.0, 5128.153854613994, 5140.4859514048485, 5143.151380022292, 5187.936473023021, 5188.818391356303, 5092.643514953955, 5101.948980510203, 5135.922961155586, 5155.040695061655, 5170.896582068356, 4722.527747225285, 4934.728589927553, 4952.727599981999, 4959.380077490314, 5082.618803589746, 4917.237828136626, 4943.77753001114, 4954.603631709455, 4956.90086198274, 4973.204287314049, 4435.29035354345, 4443.200223959686, 4456.977715111404, 4475.261581838992, 4514.277715565494, 5890.0, 5936.821895343147, 5991.161237426763, 5993.160957465958, 6024.909626355608, 5628.0, 5631.718414079321, 5639.887202255932, 5660.66036037835, 5664.2636457260705, 6407.903881441782, 6411.615303081783, 6479.546431749779, 6506.512011599101, 6536.215654121488, 4633.142868569292, 4773.665843390964, 4842.394700662418, 4850.975745121252, 4909.214525675875, 6556.803295901131, 6642.335766423319, 6670.866582668319, 6679.732810687567, 6696.397324240842, 4968.428630707443, 4980.0, 4991.5541384721955, 5014.147594908802, 5024.773885175176, 5071.163258062378, 5074.746262686851, 5082.74586270685, 5100.183970564692, 5105.132127538327, 5564.8330550083565, 5566.666000040011, 5620.831375058755, 5624.71876406178, 5662.971685141631, 6507.577007494498, 6530.1510803596175, 6533.3339998300125, 6542.967285163639, 6555.704993275314, 1744.1366523570914, 1750.9912450437666, 1754.333353325728, 1758.2791055667115, 1758.3933542927668, 1147.5696613769837, 1232.1744431231098, 1234.8888600026041, 1235.407004637779, 1243.4777393494753, 5531.308586426697, 5545.667259964334, 5573.164025396142, 5577.135543990688, 5644.491995720405, 6487.481001519867, 6493.642849643315, 6537.5096867734155, 6548.607083575001, 6562.507811914125, 5539.642787517004, 5594.888102237933, 5599.356074051455, 5617.887642247132, 5632.155176723524, 3400.4559270516597, 3409.6419875913166, 3419.897403077912, 3441.896743097661, 3472.7048200903205, 6295.0, 6315.052742088724, 6369.617822930639, 6370.968145159244, 6429.324920883333, 6607.9669601651685, 6615.338466153443, 6661.633610151392, 6699.899501507482, 6721.1262535871, 5879.148068358453, 6252.562320637512, 6253.155823963707, 6357.936420635827, 6391.904121438182, 6406.327335629691, 6442.774502892376, 6503.382178693017, 6565.934340656723, 6576.0, 6487.3836985486305, 6518.0, 6581.0, 6597.4392176663605, 6606.8348291293105, 6249.312575616769, 6301.40136687014, 6347.460465860268, 6442.645654488861, 6460.86647975722, 4794.496577859414, 4947.886725486736, 4960.50394960501, 4967.776450059684, 4973.626977976739, 6318.9052164216655, 6431.549791514549, 6483.902741458976, 6513.8697226056165, 6563.9343606565235, 6223.782167624111, 6293.905591416041, 6316.810495685137, 6339.890519159221, 6390.360963903572, 6339.587926784744, 6355.777547785805, 6366.3633636637815, 6399.568164097613, 6444.45222156122, 6290.748370065146, 6296.087067375296, 6304.369563043659, 6329.683515824282, 6357.300696923242, 6346.460550853045, 6396.296407395276, 6417.390347917127, 6453.193350831146, 6494.220693516808, 6210.782622608187, 6231.906521402092, 6249.218847644044, 6265.530085243534, 6293.576972865389], "value": 4982.9237154339135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.8057827277996, 906.0576999920083, 908.950007749574, 921.5069937583394, 930.9487978161201, 17367.565810854718, 17872.0, 17878.195481203344, 17908.194131264092, 17918.19368128434, 18720.438386848382, 18744.625107497843, 18964.715529267072, 19178.616427671437, 19321.51696207592, 939.1219210038602, 968.9224862011022, 971.2084651009404, 972.3145182646217, 973.060996138726, 974.5906719177926, 986.654670865195, 992.1170158558888, 994.2741798487073, 996.9980169929211, 976.2726768557435, 1008.7478130467383, 1010.4846528270598, 1012.1902478017556, 1013.6401577440013, 993.4039576254189, 993.5677980078689, 999.3404353126901, 1000.8098461292332, 1006.8288390973552, 719.8200449887528, 738.818989347608, 746.932776050158, 749.6738918570385, 752.259024860512, 19390.127444265043, 19462.416127516055, 19627.509312267164, 19641.116149773294, 19641.41075767729, 21435.892820535955, 21681.0, 22101.557968840694, 22170.11319547216, 22411.103555857746, 17427.215775290144, 17603.471895843144, 17766.0, 17894.55263618407, 18180.090995450308, 3696.3346597612417, 3781.716371272166, 3782.602826703184, 3782.8486860525823, 3785.4889589905288, 136299.0, 137459.0, 138565.3071734645, 138738.0, 142805.0, 16664.83335166657, 16904.0, 16932.730045246655, 17175.656486870193, 17286.481405557854, 30847.2288192797, 31421.37157256842, 31439.214019649233, 31892.521612175835, 32302.83848580789, 9027.00702922678, 9085.863712044325, 9139.314551408672, 9145.77135571616, 9170.082991700776, 4174.958250417518, 4273.188094262143, 4335.739855608674, 4378.190034843564, 4393.956060439355, 5539.584531160179, 5625.240592519957, 5662.952353814558, 5668.291463567054, 5687.175359572839, 1006.9848952265722, 1029.5006921642996, 1048.2347886043078, 1051.3849398102195, 1054.383185836279, 656.9934300657028, 670.1422179610107, 674.6727836999052, 677.5968298862169, 697.104221075915, 11007.504662290215, 11366.488508017159, 11752.647420577396, 12271.325077120844, 12289.0, 618.3352895637119, 619.5693992675137, 622.1911515030442, 631.4537924695197, 644.7839973608893, 5514.641548299428, 5572.219889215513, 5578.612488700415, 5652.293463317085, 5762.855928601818, 124463.2104934416, 127159.0, 129182.0, 129246.0, 132426.0, 113136.43431782788, 115905.0, 116821.41589291999, 117422.0, 118802.40598796951, 95860.52069739606, 101524.0, 101960.0, 102520.0, 104291.99999999849, 10188.643397481053, 10300.793984120126, 10411.843822342822, 10656.57373705043, 10822.67531974042, 45275.320870187636, 46218.0, 46938.0, 47399.76300118477, 47604.0, 60655.393446064976, 61666.69166654138, 62995.0, 63156.0, 63362.0, 15398.9230053849, 15420.768688469458, 15661.84338156604, 15691.686166276382, 15801.841981580037, 17036.82963170402, 17343.392981245597, 17368.26317368253, 17477.300907963538, 17787.644247115244, 16178.433754818525, 16266.0, 16381.426650067191, 16419.83580164183, 16660.833391666412, 16162.434314798926, 16356.67286654284, 16450.177491125636, 16579.50261492157, 16597.834021660114, 15859.444919428226, 15955.8404415959, 16140.0, 16149.19254037317, 16470.258838352544, 11620.5351785931, 11782.823257651313, 11862.051035916933, 11940.70148246266, 11942.761144777229, 12055.276683399024, 12120.75758484843, 12151.513939442324, 12395.008399328213, 12481.625551233477], "value": 9013.750493672811, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1446.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 107.0, 106.0, 114.0, 113.0, 115.0, 115.0, 109.0, 115.0, 118.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 118.0, 145.0, 127.0, 127.0, 116.0, 120.0, 115.0, 121.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 175.0, 170.0, 168.0, 164.0, 163.0, 174.0, 165.0, 163.0], "value": 167.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 74.0, 81.0, 75.0, 75.0, 80.0, 76.0, 77.0, 81.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 83.0, 82.0, 81.0, 85.0, 84.0, 87.0, 81.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 114.0, 111.0, 121.0, 113.0, 115.0, 115.0, 112.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 155.0, 160.0, 156.0, 147.0, 152.0, 151.0, 149.0, 158.0], "value": 152.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 102.0, 95.0, 93.0, 96.0, 96.0, 95.0, 103.0, 100.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 64.0, 51.0, 51.0, 54.0, 55.0, 50.0, 51.0, 52.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 47.0, 42.0, 44.0, 47.0, 46.0, 47.0, 37.0, 44.0, 40.0], "value": 43.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 76.0, 76.0, 75.0, 73.0, 76.0, 73.0, 74.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 126.0, 124.0, 118.0, 113.0, 127.0, 110.0, 109.0, 113.0], "value": 116.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 171.0, 163.0, 164.0, 169.0, 162.0, 163.0, 160.0, 173.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 63.0, 79.0, 67.0, 61.0, 64.0, 64.0, 63.0], "value": 65.5, "unit": "score"}]}]} 03:56:32 INFO - Return code: 0 03:56:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:32 INFO - # TBPL SUCCESS # 03:56:32 INFO - Running post-action listener: _package_coverage_data 03:56:32 INFO - Running post-action listener: _resource_record_post_action 03:56:32 INFO - [mozharness: 2017-10-01 10:56:32.686821Z] Finished run-tests step (success) 03:56:32 INFO - Running post-run listener: _resource_record_post_run 03:56:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7311360; Write bytes: 346570752; Read time: 8492; Write time: 207324 03:56:32 INFO - TinderboxPrint: CPU usage
13.2% 03:56:32 INFO - TinderboxPrint: I/O read bytes / time
7,311,360 / 8,492 03:56:32 INFO - TinderboxPrint: I/O write bytes / time
346,570,752 / 207,324 03:56:32 INFO - TinderboxPrint: CPU idle
8,269.3 (86.8%) 03:56:32 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 03:56:32 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13189120; Read time: 0; Write time: 1760 03:56:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:56:32 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 7307264; Write bytes: 333381632; Read time: 8480; Write time: 205564 03:56:33 INFO - Running post-run listener: _upload_blobber_files 03:56:33 INFO - Blob upload gear active. 03:56:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:56:33 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:34 INFO - (blobuploader) - INFO - Done attempting. 03:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:35 INFO - (blobuploader) - INFO - Done attempting. 03:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:42 INFO - (blobuploader) - INFO - Done attempting. 03:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:43 INFO - (blobuploader) - INFO - Done attempting. 03:56:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:43 INFO - Return code: 0 03:56:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddb32168c11f9ab6e53e492741c52a16b49c98e6dcb36217e65f10c26ab4d64f61a749984915f4479fc0e0134e689ca8bf01840037625ecbd9cac72642c2d986", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6521708d54c394b5fa84baf52d424c4ace34a556534756d48b2c0034dfcaebc62e9794dd1865d8fceaed2da7c8c51ede498d20e693c73596af763e5059fec7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa086f1e36564f8af9267b972a6c6a2f31b90eb7efdbca564201256398a4cb3d17796786d25f2b73883da296dc965db20220adac8bbd38b3dcac2efe681328", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e708bba2d4185705b20364643bdeca41c28e7df5c85c66987e55021a2947f458841f5431f533f2f0737ae5fba64379d78cfb8f519f0ed3d47ba437f136b0ac30"} 03:56:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:43 INFO - Contents: 03:56:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddb32168c11f9ab6e53e492741c52a16b49c98e6dcb36217e65f10c26ab4d64f61a749984915f4479fc0e0134e689ca8bf01840037625ecbd9cac72642c2d986", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6521708d54c394b5fa84baf52d424c4ace34a556534756d48b2c0034dfcaebc62e9794dd1865d8fceaed2da7c8c51ede498d20e693c73596af763e5059fec7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa086f1e36564f8af9267b972a6c6a2f31b90eb7efdbca564201256398a4cb3d17796786d25f2b73883da296dc965db20220adac8bbd38b3dcac2efe681328", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e708bba2d4185705b20364643bdeca41c28e7df5c85c66987e55021a2947f458841f5431f533f2f0737ae5fba64379d78cfb8f519f0ed3d47ba437f136b0ac30"} 03:56:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:43 INFO - Copying logs to upload dir... 03:56:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.398167 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-10-01 03:56:43.619532) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 03:56:43.623684) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793 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/ddb32168c11f9ab6e53e492741c52a16b49c98e6dcb36217e65f10c26ab4d64f61a749984915f4479fc0e0134e689ca8bf01840037625ecbd9cac72642c2d986", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6521708d54c394b5fa84baf52d424c4ace34a556534756d48b2c0034dfcaebc62e9794dd1865d8fceaed2da7c8c51ede498d20e693c73596af763e5059fec7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa086f1e36564f8af9267b972a6c6a2f31b90eb7efdbca564201256398a4cb3d17796786d25f2b73883da296dc965db20220adac8bbd38b3dcac2efe681328", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e708bba2d4185705b20364643bdeca41c28e7df5c85c66987e55021a2947f458841f5431f533f2f0737ae5fba64379d78cfb8f519f0ed3d47ba437f136b0ac30"} build_url:https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/QOqsB9orQMKqBzUJ4z8NXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddb32168c11f9ab6e53e492741c52a16b49c98e6dcb36217e65f10c26ab4d64f61a749984915f4479fc0e0134e689ca8bf01840037625ecbd9cac72642c2d986", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6521708d54c394b5fa84baf52d424c4ace34a556534756d48b2c0034dfcaebc62e9794dd1865d8fceaed2da7c8c51ede498d20e693c73596af763e5059fec7b", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bfa086f1e36564f8af9267b972a6c6a2f31b90eb7efdbca564201256398a4cb3d17796786d25f2b73883da296dc965db20220adac8bbd38b3dcac2efe681328", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e708bba2d4185705b20364643bdeca41c28e7df5c85c66987e55021a2947f458841f5431f533f2f0737ae5fba64379d78cfb8f519f0ed3d47ba437f136b0ac30"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-01 03:56:43.653401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:56:43.653746) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1506839488.259287-712244793 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-01 03:56:43.736708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 03:56:43.737100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-01 03:56:43.737416) ========= ========= Total master_lag: 0.19 =========