builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1504635912.4 results: success (0) revision: 973e8b890a62aee4b3170558ac3b608928162ef6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.403636) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.404082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.404436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.449134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.449993) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-05 11:25:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 98.8M=0s 2017-09-05 11:25:12 (98.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.607092) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.607455) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.664013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:12.664315) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 973e8b890a62aee4b3170558ac3b608928162ef6 --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 973e8b890a62aee4b3170558ac3b608928162ef6 --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=e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-05 11:25:12,640 truncating revision to first 12 chars 2017-09-05 11:25:12,640 Setting DEBUG logging. 2017-09-05 11:25:12,640 attempt 1/10 2017-09-05 11:25:12,640 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/973e8b890a62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-05 11:25:12,924 unpacking tar archive at: mozilla-central-973e8b890a62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.293223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.293522) ========= script_repo_revision: 973e8b890a62aee4b3170558ac3b608928162ef6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.293882) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.294344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-05 11:25:13.309101) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-09-05 11:25:13.309381) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:25:13 INFO - MultiFileLogger online at 20170905 11:25:13 in /builds/slave/test 11:25:13 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 11:25:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:25:13 INFO - {'append_to_log': False, 11:25:13 INFO - 'base_work_dir': '/builds/slave/test', 11:25:13 INFO - 'blob_upload_branch': 'Firefox', 11:25:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:25:13 INFO - 'branch': 'Firefox', 11:25:13 INFO - 'buildbot_json_path': 'buildprops.json', 11:25:13 INFO - 'code_coverage': False, 11:25:13 INFO - 'config_files': ('talos/linux_config.py',), 11:25:13 INFO - 'default_actions': ('clobber', 11:25:13 INFO - 'read-buildbot-config', 11:25:13 INFO - 'download-and-extract', 11:25:13 INFO - 'populate-webroot', 11:25:13 INFO - 'create-virtualenv', 11:25:13 INFO - 'install', 11:25:13 INFO - 'setup-mitmproxy', 11:25:13 INFO - 'run-tests'), 11:25:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:25:13 INFO - 'disable_ccov_upload': False, 11:25:13 INFO - 'disable_stylo': False, 11:25:13 INFO - 'download_minidump_stackwalk': True, 11:25:13 INFO - 'download_symbols': 'ondemand', 11:25:13 INFO - 'enable_stylo': False, 11:25:13 INFO - 'enable_webrender': False, 11:25:13 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:25:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:25:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:25:13 INFO - 'gecko_profile': False, 11:25:13 INFO - 'gecko_profile_interval': 0, 11:25:13 INFO - 'installer_path': 'installer.exe', 11:25:13 INFO - 'log_level': 'info', 11:25:13 INFO - 'log_name': 'talos', 11:25:13 INFO - 'log_to_console': True, 11:25:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:25:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:25:13 INFO - 'opt_config_files': (), 11:25:13 INFO - 'pip_index': False, 11:25:13 INFO - 'suite': 'dromaeojs-e10s', 11:25:13 INFO - 'system_bits': '32', 11:25:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:25:13 INFO - 'title': 'talos-linux64-ix-006', 11:25:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:25:13 INFO - 'use_talos_json': True, 11:25:13 INFO - 'verify': 'False', 11:25:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:25:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:25:13 INFO - 'work_dir': 'build'} 11:25:13 INFO - [mozharness: 2017-09-05 18:25:13.421503Z] Running clobber step. 11:25:13 INFO - Running pre-action listener: _resource_record_pre_action 11:25:13 INFO - Running main action method: clobber 11:25:13 INFO - rmtree: /builds/slave/test/build 11:25:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:25:14 INFO - Running post-action listener: _resource_record_post_action 11:25:14 INFO - [mozharness: 2017-09-05 18:25:14.953955Z] Finished clobber step (success) 11:25:14 INFO - [mozharness: 2017-09-05 18:25:14.954052Z] Running read-buildbot-config step. 11:25:14 INFO - Running pre-action listener: _resource_record_pre_action 11:25:14 INFO - Running main action method: read_buildbot_config 11:25:14 INFO - Using buildbot properties: 11:25:14 INFO - { 11:25:14 INFO - "project": "", 11:25:14 INFO - "product": "firefox", 11:25:14 INFO - "who": "ffxbld@noreply.mozilla.org", 11:25:14 INFO - "installer_path": "public/build/target.tar.bz2", 11:25:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:25:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:25:14 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:25:14 INFO - "stage_platform": "linux64-qr", 11:25:14 INFO - "basedir": "/builds/slave/test", 11:25:14 INFO - "buildnumber": 32, 11:25:14 INFO - "platform": "ubuntu64_hw_qr", 11:25:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:25:14 INFO - "slavebuilddir": "test", 11:25:14 INFO - "taskId": "Y8B_TJ0oSeaKWT3KEnS9Eg", 11:25:14 INFO - "branch": "mozilla-central", 11:25:14 INFO - "script_repo_revision": "production", 11:25:14 INFO - "revision": "973e8b890a62aee4b3170558ac3b608928162ef6", 11:25:14 INFO - "slavename": "talos-linux64-ix-006", 11:25:14 INFO - "repo_path": "mozilla-central" 11:25:14 INFO - } 11:25:14 INFO - Finding installer, test and symbols from parent task. 11:25:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8B_TJ0oSeaKWT3KEnS9Eg'}, attempt #1 11:25:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8B_TJ0oSeaKWT3KEnS9Eg'}, attempt #1 11:25:15 INFO - Task dependencies: TJbnw1eAT3m2u_5HiPuYfA 11:25:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA'}, attempt #1 11:25:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json 11:25:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip 11:25:16 INFO - Running post-action listener: _resource_record_post_action 11:25:16 INFO - [mozharness: 2017-09-05 18:25:16.328501Z] Finished read-buildbot-config step (success) 11:25:16 INFO - [mozharness: 2017-09-05 18:25:16.328725Z] Running download-and-extract step. 11:25:16 INFO - Running pre-action listener: _resource_record_pre_action 11:25:16 INFO - Running main action method: download_and_extract 11:25:16 INFO - mkdir: /builds/slave/test/build/tests 11:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:16 INFO - trying https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json 11:25:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:25:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:25:16 INFO - Downloaded 989 bytes. 11:25:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:25:16 INFO - Using the following test package requirements: 11:25:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:25:16 INFO - u'common': [u'target.common.tests.zip'], 11:25:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:25:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:25:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:25:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:25:16 INFO - u'mozbase': [u'target.common.tests.zip'], 11:25:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:25:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:25:16 INFO - u'web-platform': [u'target.common.tests.zip', 11:25:16 INFO - u'target.web-platform.tests.tar.gz'], 11:25:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:25:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:25:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip 11:25:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:16 INFO - Fetch https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip into memory 11:25:17 INFO - Content-Length response header: 55022217 11:25:17 INFO - Bytes received: 55022217 11:25:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:25:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip 11:25:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:25:28 INFO - Fetch https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.common.tests.zip into memory 11:25:30 INFO - Content-Length response header: 55022217 11:25:30 INFO - Bytes received: 55022217 11:25:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.talos.tests.zip 11:25:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:25:42 INFO - Fetch https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.talos.tests.zip into memory 11:25:43 INFO - Content-Length response header: 14496650 11:25:43 INFO - Bytes received: 14496650 11:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:44 INFO - trying https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:44 INFO - Downloading https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:25:45 INFO - Downloaded 62644193 bytes. 11:25:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:45 INFO - mkdir: /builds/slave/test/properties 11:25:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:45 INFO - Contents: 11:25:45 INFO - build_url:https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 11:25:45 INFO - Running post-action listener: _resource_record_post_action 11:25:45 INFO - Running post-action listener: find_tests_for_verification 11:25:45 INFO - Running post-action listener: set_extra_try_arguments 11:25:45 INFO - [mozharness: 2017-09-05 18:25:45.349890Z] Finished download-and-extract step (success) 11:25:45 INFO - [mozharness: 2017-09-05 18:25:45.349987Z] Running populate-webroot step. 11:25:45 INFO - Running pre-action listener: _resource_record_pre_action 11:25:45 INFO - Running main action method: populate_webroot 11:25:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:45 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:45 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:45 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'tests': ['damp', 'tps']}, 11:25:45 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['damp', 'tps']}, 11:25:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:25:45 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:25:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:25:45 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:25:45 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:45 INFO - 'ts_paint', 11:25:45 INFO - 'tpaint', 11:25:45 INFO - 'sessionrestore', 11:25:45 INFO - 'sessionrestore_many_windows', 11:25:45 INFO - 'sessionrestore_no_auto_restore', 11:25:45 INFO - 'tabpaint']}, 11:25:45 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['a11yr', 11:25:45 INFO - 'ts_paint', 11:25:45 INFO - 'tpaint', 11:25:45 INFO - 'sessionrestore', 11:25:45 INFO - 'sessionrestore_many_windows', 11:25:45 INFO - 'sessionrestore_no_auto_restore', 11:25:45 INFO - 'tabpaint']}, 11:25:45 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:25:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:25:45 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['bloom_basic_singleton']}, 11:25:45 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['bloom_basic']}, 11:25:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:45 INFO - 'tsvgr_opacity', 11:25:45 INFO - 'tart', 11:25:45 INFO - 'tscrollx', 11:25:45 INFO - 'tsvg_static']}, 11:25:45 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['tsvgx', 11:25:45 INFO - 'tsvgr_opacity', 11:25:45 INFO - 'tart', 11:25:45 INFO - 'tscrollx', 11:25:45 INFO - 'tsvg_static']}, 11:25:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:25:45 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo'], 11:25:45 INFO - 'tests': ['tp5o']}, 11:25:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:45 INFO - 'talos_options': ['--mitmproxy', 11:25:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:45 INFO - '--firstNonBlankPaint'], 11:25:45 INFO - 'tests': ['tp6_google', 11:25:45 INFO - 'tp6_youtube', 11:25:45 INFO - 'tp6_amazon', 11:25:45 INFO - 'tp6_facebook']}, 11:25:45 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo', 11:25:45 INFO - '--mitmproxy', 11:25:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:45 INFO - '--firstNonBlankPaint'], 11:25:45 INFO - 'tests': ['tp6_google', 11:25:45 INFO - 'tp6_youtube', 11:25:45 INFO - 'tp6_amazon', 11:25:45 INFO - 'tp6_facebook']}, 11:25:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo', 11:25:45 INFO - '--stylo-threads=1', 11:25:45 INFO - '--mitmproxy', 11:25:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:25:45 INFO - '--firstNonBlankPaint'], 11:25:45 INFO - 'tests': ['tp6_google', 11:25:45 INFO - 'tp6_youtube', 11:25:45 INFO - 'tp6_amazon', 11:25:45 INFO - 'tp6_facebook']}, 11:25:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'talos_options': ['--xperf_path', 11:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:45 INFO - 'tests': ['tp5n']}, 11:25:45 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:25:45 INFO - 'talos_options': ['--enable-stylo', 11:25:45 INFO - '--xperf_path', 11:25:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:45 INFO - 'tests': ['tp5n']}}} 11:25:45 INFO - Running post-action listener: _resource_record_post_action 11:25:45 INFO - [mozharness: 2017-09-05 18:25:45.364329Z] Finished populate-webroot step (success) 11:25:45 INFO - [mozharness: 2017-09-05 18:25:45.364418Z] Running create-virtualenv step. 11:25:45 INFO - Running pre-action listener: _resource_record_pre_action 11:25:45 INFO - Running main action method: create_virtualenv 11:25:45 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:25:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:25:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:25:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:46 INFO - Installing pip...............done. 11:25:46 INFO - Return code: 0 11:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:25:46 INFO - Reading from file tmpfile_stdout 11:25:46 INFO - Output received: 11:25:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:25:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:25:46 INFO - Using env: {'DISPLAY': ':0', 11:25:46 INFO - 'HOME': '/home/cltbld', 11:25:46 INFO - 'LANG': 'en_US.UTF-8', 11:25:46 INFO - 'LANGUAGE': 'en_US:en', 11:25:46 INFO - 'LOGNAME': 'cltbld', 11:25:46 INFO - 'MAIL': '/var/mail/cltbld', 11:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:46 INFO - 'MOZ_NO_REMOTE': '1', 11:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:46 INFO - 'NO_EM_RESTART': '1', 11:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:46 INFO - 'PWD': '/builds/slave/test', 11:25:46 INFO - 'SHELL': '/bin/bash', 11:25:46 INFO - 'SHLVL': '1', 11:25:46 INFO - 'TERM': 'linux', 11:25:46 INFO - 'TMOUT': '86400', 11:25:46 INFO - 'USER': 'cltbld', 11:25:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:46 INFO - '_': '/tools/buildbot/bin/python'} 11:25:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:25:47 INFO - Downloading/unpacking pip>=1.5 11:25:47 INFO - Running setup.py egg_info for package pip 11:25:47 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:47 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:47 INFO - Installing collected packages: pip 11:25:47 INFO - Found existing installation: pip 1.1 11:25:47 INFO - Uninstalling pip: 11:25:47 INFO - Successfully uninstalled pip 11:25:47 INFO - Running setup.py install for pip 11:25:47 INFO - warning: no files found matching 'pip/cacert.pem' 11:25:47 INFO - warning: no files found matching '*.html' under directory 'docs' 11:25:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:25:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:25:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:25:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:25:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:25:47 INFO - Successfully installed pip 11:25:47 INFO - Cleaning up... 11:25:47 INFO - Return code: 0 11:25:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:47 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')]} 11:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:47 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')]} 11:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:47 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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:47 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 11:25:47 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 11:25:47 INFO - Using env: {'DISPLAY': ':0', 11:25:47 INFO - 'HOME': '/home/cltbld', 11:25:47 INFO - 'LANG': 'en_US.UTF-8', 11:25:47 INFO - 'LANGUAGE': 'en_US:en', 11:25:47 INFO - 'LOGNAME': 'cltbld', 11:25:47 INFO - 'MAIL': '/var/mail/cltbld', 11:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:47 INFO - 'MOZ_NO_REMOTE': '1', 11:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:47 INFO - 'NO_EM_RESTART': '1', 11:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:47 INFO - 'PWD': '/builds/slave/test', 11:25:47 INFO - 'SHELL': '/bin/bash', 11:25:47 INFO - 'SHLVL': '1', 11:25:47 INFO - 'TERM': 'linux', 11:25:47 INFO - 'TMOUT': '86400', 11:25:47 INFO - 'USER': 'cltbld', 11:25:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:47 INFO - '_': '/tools/buildbot/bin/python'} 11:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:47 INFO - Downloading/unpacking psutil>=3.1.1 11:25:47 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 11:25:47 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 11:25:47 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 11:25:47 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 11:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:48 INFO - Installing collected packages: psutil 11:25:48 INFO - Running setup.py install for psutil 11:25:49 INFO - building 'psutil._psutil_linux' extension 11:25:49 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 11:25:49 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 11:25:49 INFO - building 'psutil._psutil_posix' extension 11:25:49 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 11:25:49 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 11:25:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:49 INFO - Successfully installed psutil 11:25:49 INFO - Cleaning up... 11:25:49 INFO - Return code: 0 11:25:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:25:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:25:49 INFO - Using env: {'DISPLAY': ':0', 11:25:49 INFO - 'HOME': '/home/cltbld', 11:25:49 INFO - 'LANG': 'en_US.UTF-8', 11:25:49 INFO - 'LANGUAGE': 'en_US:en', 11:25:49 INFO - 'LOGNAME': 'cltbld', 11:25:49 INFO - 'MAIL': '/var/mail/cltbld', 11:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:49 INFO - 'MOZ_NO_REMOTE': '1', 11:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:49 INFO - 'NO_EM_RESTART': '1', 11:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:49 INFO - 'PWD': '/builds/slave/test', 11:25:49 INFO - 'SHELL': '/bin/bash', 11:25:49 INFO - 'SHLVL': '1', 11:25:49 INFO - 'TERM': 'linux', 11:25:49 INFO - 'TMOUT': '86400', 11:25:49 INFO - 'USER': 'cltbld', 11:25:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:49 INFO - '_': '/tools/buildbot/bin/python'} 11:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:50 INFO - Installing collected packages: mozsystemmonitor 11:25:50 INFO - Running setup.py install for mozsystemmonitor 11:25:50 INFO - Successfully installed mozsystemmonitor 11:25:50 INFO - Cleaning up... 11:25:50 INFO - Return code: 0 11:25:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:50 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')]} 11:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:50 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')]} 11:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:51 INFO - Using env: {'DISPLAY': ':0', 11:25:51 INFO - 'HOME': '/home/cltbld', 11:25:51 INFO - 'LANG': 'en_US.UTF-8', 11:25:51 INFO - 'LANGUAGE': 'en_US:en', 11:25:51 INFO - 'LOGNAME': 'cltbld', 11:25:51 INFO - 'MAIL': '/var/mail/cltbld', 11:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:51 INFO - 'MOZ_NO_REMOTE': '1', 11:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:51 INFO - 'NO_EM_RESTART': '1', 11:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:51 INFO - 'PWD': '/builds/slave/test', 11:25:51 INFO - 'SHELL': '/bin/bash', 11:25:51 INFO - 'SHLVL': '1', 11:25:51 INFO - 'TERM': 'linux', 11:25:51 INFO - 'TMOUT': '86400', 11:25:51 INFO - 'USER': 'cltbld', 11:25:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:51 INFO - '_': '/tools/buildbot/bin/python'} 11:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:52 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 11:25:52 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 11:25:52 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 11:25:52 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 11:25:52 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:52 INFO - warning: no files found matching '*.txt' 11:25:52 INFO - no previously-included directories found matching 'build' 11:25:52 INFO - no previously-included directories found matching 'dist' 11:25:52 INFO - no previously-included directories found matching '.git*' 11:25:52 INFO - Installing collected packages: jsonschema, functools32 11:25:52 INFO - Running setup.py install for functools32 11:25:52 INFO - warning: no files found matching '*.txt' 11:25:52 INFO - no previously-included directories found matching 'build' 11:25:52 INFO - no previously-included directories found matching 'dist' 11:25:52 INFO - no previously-included directories found matching '.git*' 11:25:52 INFO - Successfully installed jsonschema functools32 11:25:52 INFO - Cleaning up... 11:25:52 INFO - Return code: 0 11:25:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:52 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')]} 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:52 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')]} 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:52 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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:52 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 11:25:52 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 11:25:52 INFO - Using env: {'DISPLAY': ':0', 11:25:52 INFO - 'HOME': '/home/cltbld', 11:25:52 INFO - 'LANG': 'en_US.UTF-8', 11:25:52 INFO - 'LANGUAGE': 'en_US:en', 11:25:52 INFO - 'LOGNAME': 'cltbld', 11:25:52 INFO - 'MAIL': '/var/mail/cltbld', 11:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:52 INFO - 'MOZ_NO_REMOTE': '1', 11:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:52 INFO - 'NO_EM_RESTART': '1', 11:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:52 INFO - 'PWD': '/builds/slave/test', 11:25:52 INFO - 'SHELL': '/bin/bash', 11:25:52 INFO - 'SHLVL': '1', 11:25:52 INFO - 'TERM': 'linux', 11:25:52 INFO - 'TMOUT': '86400', 11:25:52 INFO - 'USER': 'cltbld', 11:25:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:52 INFO - '_': '/tools/buildbot/bin/python'} 11:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:52 INFO - Cleaning up... 11:25:52 INFO - Return code: 0 11:25:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:52 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')]} 11:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:52 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')]} 11:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:52 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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:52 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 11:25:52 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 11:25:52 INFO - Using env: {'DISPLAY': ':0', 11:25:52 INFO - 'HOME': '/home/cltbld', 11:25:52 INFO - 'LANG': 'en_US.UTF-8', 11:25:52 INFO - 'LANGUAGE': 'en_US:en', 11:25:52 INFO - 'LOGNAME': 'cltbld', 11:25:52 INFO - 'MAIL': '/var/mail/cltbld', 11:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:52 INFO - 'MOZ_NO_REMOTE': '1', 11:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:52 INFO - 'NO_EM_RESTART': '1', 11:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:52 INFO - 'PWD': '/builds/slave/test', 11:25:52 INFO - 'SHELL': '/bin/bash', 11:25:52 INFO - 'SHLVL': '1', 11:25:52 INFO - 'TERM': 'linux', 11:25:52 INFO - 'TMOUT': '86400', 11:25:52 INFO - 'USER': 'cltbld', 11:25:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:52 INFO - '_': '/tools/buildbot/bin/python'} 11:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:54 INFO - Downloading docopt-0.6.1.tar.gz 11:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:54 INFO - Running setup.py install for blobuploader 11:25:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:54 INFO - Running setup.py install for requests 11:25:55 INFO - Running setup.py install for docopt 11:25:55 INFO - Successfully installed blobuploader requests docopt 11:25:55 INFO - Cleaning up... 11:25:55 INFO - Return code: 0 11:25:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:55 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')]} 11:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:55 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')]} 11:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:55 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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:55 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 11:25:55 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 11:25:55 INFO - Using env: {'DISPLAY': ':0', 11:25:55 INFO - 'HOME': '/home/cltbld', 11:25:55 INFO - 'LANG': 'en_US.UTF-8', 11:25:55 INFO - 'LANGUAGE': 'en_US:en', 11:25:55 INFO - 'LOGNAME': 'cltbld', 11:25:55 INFO - 'MAIL': '/var/mail/cltbld', 11:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:55 INFO - 'MOZ_NO_REMOTE': '1', 11:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:55 INFO - 'NO_EM_RESTART': '1', 11:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:55 INFO - 'PWD': '/builds/slave/test', 11:25:55 INFO - 'SHELL': '/bin/bash', 11:25:55 INFO - 'SHLVL': '1', 11:25:55 INFO - 'TERM': 'linux', 11:25:55 INFO - 'TMOUT': '86400', 11:25:55 INFO - 'USER': 'cltbld', 11:25:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:55 INFO - '_': '/tools/buildbot/bin/python'} 11:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:55 INFO - Running setup.py (path:/tmp/pip-tnLTFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:55 INFO - Running setup.py (path:/tmp/pip-ADpLss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:55 INFO - Running setup.py (path:/tmp/pip-wYSWTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:55 INFO - Running setup.py (path:/tmp/pip-Bj6pBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:55 INFO - Running setup.py (path:/tmp/pip-qBgGmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:55 INFO - Running setup.py (path:/tmp/pip-h2tbvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:56 INFO - Running setup.py (path:/tmp/pip-Obyegz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:56 INFO - Running setup.py (path:/tmp/pip-FaL9Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:56 INFO - Running setup.py (path:/tmp/pip-wbkp3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:56 INFO - Running setup.py (path:/tmp/pip-CRGlXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:56 INFO - Running setup.py (path:/tmp/pip-Wijc6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:56 INFO - Running setup.py (path:/tmp/pip-hNhczP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:56 INFO - Running setup.py (path:/tmp/pip-G2iTwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:56 INFO - Running setup.py (path:/tmp/pip-uOntex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:56 INFO - Running setup.py (path:/tmp/pip-Le_fPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:56 INFO - Running setup.py (path:/tmp/pip-3HJ27A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:56 INFO - Running setup.py (path:/tmp/pip-0Dr0PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:56 INFO - Running setup.py install for manifestparser 11:25:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:56 INFO - Running setup.py install for mozcrash 11:25:57 INFO - Running setup.py install for mozdebug 11:25:57 INFO - Running setup.py install for mozdevice 11:25:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Running setup.py install for mozfile 11:25:57 INFO - Running setup.py install for mozhttpd 11:25:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Running setup.py install for mozinfo 11:25:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Running setup.py install for mozInstall 11:25:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Running setup.py install for mozleak 11:25:57 INFO - Running setup.py install for mozlog 11:25:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Running setup.py install for moznetwork 11:25:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:57 INFO - Running setup.py install for mozprocess 11:25:58 INFO - Running setup.py install for mozprofile 11:25:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:58 INFO - Running setup.py install for mozrunner 11:25:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:58 INFO - Running setup.py install for mozscreenshot 11:25:58 INFO - Running setup.py install for moztest 11:25:58 INFO - Running setup.py install for mozversion 11:25:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:58 INFO - Cleaning up... 11:25:58 INFO - Return code: 0 11:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:58 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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:25:58 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 11:25:58 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 11:25:58 INFO - Using env: {'DISPLAY': ':0', 11:25:58 INFO - 'HOME': '/home/cltbld', 11:25:58 INFO - 'LANG': 'en_US.UTF-8', 11:25:58 INFO - 'LANGUAGE': 'en_US:en', 11:25:58 INFO - 'LOGNAME': 'cltbld', 11:25:58 INFO - 'MAIL': '/var/mail/cltbld', 11:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:58 INFO - 'MOZ_NO_REMOTE': '1', 11:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:58 INFO - 'NO_EM_RESTART': '1', 11:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:58 INFO - 'PWD': '/builds/slave/test', 11:25:58 INFO - 'SHELL': '/bin/bash', 11:25:58 INFO - 'SHLVL': '1', 11:25:58 INFO - 'TERM': 'linux', 11:25:58 INFO - 'TMOUT': '86400', 11:25:58 INFO - 'USER': 'cltbld', 11:25:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:58 INFO - '_': '/tools/buildbot/bin/python'} 11:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:58 INFO - Running setup.py (path:/tmp/pip-5Vj1I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:58 INFO - Running setup.py (path:/tmp/pip-N6ILXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:58 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)) 11:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:58 INFO - Running setup.py (path:/tmp/pip-P7fyEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:59 INFO - Running setup.py (path:/tmp/pip-bj5K9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:59 INFO - Running setup.py (path:/tmp/pip-1SU7DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:59 INFO - Running setup.py (path:/tmp/pip-Ctysgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:59 INFO - Running setup.py (path:/tmp/pip-ubrKSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:59 INFO - Running setup.py (path:/tmp/pip-KuBHKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:59 INFO - Running setup.py (path:/tmp/pip-QUZXoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:59 INFO - Running setup.py (path:/tmp/pip-f7Hcgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:59 INFO - Running setup.py (path:/tmp/pip-hzgCt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:59 INFO - Running setup.py (path:/tmp/pip-rNWTrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:59 INFO - Running setup.py (path:/tmp/pip-aRzsV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:59 INFO - Running setup.py (path:/tmp/pip-q3GW50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:59 INFO - Running setup.py (path:/tmp/pip-8hB1QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:59 INFO - Running setup.py (path:/tmp/pip-ZWlSGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:59 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)) 11:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:59 INFO - Running setup.py (path:/tmp/pip-5DETTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 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)) 11:26:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:00 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 11:26:00 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 11:26:00 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 11:26:00 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 11:26:01 INFO - Downloading blessings-1.6.tar.gz 11:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:01 INFO - Installing collected packages: blessings 11:26:01 INFO - Running setup.py install for blessings 11:26:01 INFO - Successfully installed blessings 11:26:01 INFO - Cleaning up... 11:26:01 INFO - Return code: 0 11:26:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:01 INFO - Reading from file tmpfile_stdout 11:26:01 INFO - Current package versions: 11:26:01 INFO - argparse == 1.2.1 11:26:01 INFO - blessings == 1.6 11:26:01 INFO - blobuploader == 1.2.4 11:26:01 INFO - docopt == 0.6.1 11:26:01 INFO - functools32 == 3.2.3-2 11:26:01 INFO - jsonschema == 2.5.1 11:26:01 INFO - manifestparser == 1.1 11:26:01 INFO - mozInstall == 1.13 11:26:01 INFO - mozcrash == 1.0 11:26:01 INFO - mozdebug == 0.1 11:26:01 INFO - mozdevice == 0.51 11:26:01 INFO - mozfile == 1.2 11:26:01 INFO - mozhttpd == 0.7 11:26:01 INFO - mozinfo == 0.10 11:26:01 INFO - mozleak == 0.1 11:26:01 INFO - mozlog == 3.5 11:26:01 INFO - moznetwork == 0.27 11:26:01 INFO - mozprocess == 0.25 11:26:01 INFO - mozprofile == 0.28 11:26:01 INFO - mozrunner == 6.13 11:26:01 INFO - mozscreenshot == 0.1 11:26:01 INFO - mozsystemmonitor == 0.3 11:26:01 INFO - moztest == 0.8 11:26:01 INFO - mozversion == 1.4 11:26:01 INFO - psutil == 3.1.1 11:26:01 INFO - requests == 1.2.3 11:26:01 INFO - wsgiref == 0.1.2 11:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:01 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 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:26:01 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 11:26:01 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 11:26:01 INFO - Using env: {'DISPLAY': ':0', 11:26:01 INFO - 'HOME': '/home/cltbld', 11:26:01 INFO - 'LANG': 'en_US.UTF-8', 11:26:01 INFO - 'LANGUAGE': 'en_US:en', 11:26:01 INFO - 'LOGNAME': 'cltbld', 11:26:01 INFO - 'MAIL': '/var/mail/cltbld', 11:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:01 INFO - 'MOZ_NO_REMOTE': '1', 11:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:01 INFO - 'NO_EM_RESTART': '1', 11:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:01 INFO - 'PWD': '/builds/slave/test', 11:26:01 INFO - 'SHELL': '/bin/bash', 11:26:01 INFO - 'SHLVL': '1', 11:26:01 INFO - 'TERM': 'linux', 11:26:01 INFO - 'TMOUT': '86400', 11:26:01 INFO - 'USER': 'cltbld', 11:26:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:01 INFO - '_': '/tools/buildbot/bin/python'} 11:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 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)) 11:26:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:26:01 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 11:26:01 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 11:26:01 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 11:26:01 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 11:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:26:02 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)) 11:26:02 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)) 11:26:02 INFO - Installing collected packages: simplejson 11:26:02 INFO - Running setup.py install for simplejson 11:26:03 INFO - building 'simplejson._speedups' extension 11:26:03 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 11:26:03 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 11:26:03 INFO - Successfully installed simplejson 11:26:03 INFO - Cleaning up... 11:26:04 INFO - Return code: 0 11:26:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b88a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', '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 11:26:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:26:04 INFO - Using env: {'DISPLAY': ':0', 11:26:04 INFO - 'HOME': '/home/cltbld', 11:26:04 INFO - 'LANG': 'en_US.UTF-8', 11:26:04 INFO - 'LANGUAGE': 'en_US:en', 11:26:04 INFO - 'LOGNAME': 'cltbld', 11:26:04 INFO - 'MAIL': '/var/mail/cltbld', 11:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:04 INFO - 'MOZ_NO_REMOTE': '1', 11:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:04 INFO - 'NO_EM_RESTART': '1', 11:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:04 INFO - 'PWD': '/builds/slave/test', 11:26:04 INFO - 'SHELL': '/bin/bash', 11:26:04 INFO - 'SHLVL': '1', 11:26:04 INFO - 'TERM': 'linux', 11:26:04 INFO - 'TMOUT': '86400', 11:26:04 INFO - 'USER': 'cltbld', 11:26:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:04 INFO - '_': '/tools/buildbot/bin/python'} 11:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:26:04 INFO - Cleaning up... 11:26:04 INFO - Return code: 0 11:26:04 INFO - Running post-action listener: _resource_record_post_action 11:26:04 INFO - Running post-action listener: _start_resource_monitoring 11:26:04 INFO - Starting resource monitoring. 11:26:04 INFO - [mozharness: 2017-09-05 18:26:04.292274Z] Finished create-virtualenv step (success) 11:26:04 INFO - [mozharness: 2017-09-05 18:26:04.292864Z] Running install step. 11:26:04 INFO - Running pre-action listener: _resource_record_pre_action 11:26:04 INFO - Running main action method: install 11:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:04 INFO - Reading from file tmpfile_stdout 11:26:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:26:04 INFO - Reading from file tmpfile_stdout 11:26:04 INFO - Output received: 11:26:04 INFO - Usage: mozinstall [options] installer 11:26:04 INFO - Options: 11:26:04 INFO - -h, --help show this help message and exit 11:26:04 INFO - -d DEST, --destination=DEST 11:26:04 INFO - Directory to install application into. [default: 11:26:04 INFO - "/builds/slave/test"] 11:26:04 INFO - --app=APP Application being installed. [default: firefox] 11:26:04 INFO - mkdir: /builds/slave/test/build/application 11:26:04 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'] 11:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:26:21 INFO - Reading from file tmpfile_stdout 11:26:21 INFO - Output received: 11:26:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:26:21 INFO - Running post-action listener: _resource_record_post_action 11:26:21 INFO - [mozharness: 2017-09-05 18:26:21.159900Z] Finished install step (success) 11:26:21 INFO - [mozharness: 2017-09-05 18:26:21.160045Z] Running setup-mitmproxy step. 11:26:21 INFO - Running pre-action listener: _resource_record_pre_action 11:26:21 INFO - Running main action method: setup_mitmproxy 11:26:21 INFO - Skipping: mitmproxy is not required 11:26:21 INFO - Running post-action listener: _resource_record_post_action 11:26:21 INFO - [mozharness: 2017-09-05 18:26:21.160753Z] Finished setup-mitmproxy step (success) 11:26:21 INFO - [mozharness: 2017-09-05 18:26:21.160973Z] Running run-tests step. 11:26:21 INFO - Running pre-action listener: _resource_record_pre_action 11:26:21 INFO - Running pre-action listener: _set_gcov_prefix 11:26:21 INFO - Running main action method: run_tests 11:26:21 WARNING - Try message not found. 11:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:26:21 INFO - Python 2.7.3 11:26:21 INFO - Return code: 0 11:26:21 INFO - grabbing minidump binary from tooltool 11:26: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')]} 11:26:21 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 0x2b8c090>, '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 0x2b8cd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b86f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:26:21 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 11:26:21 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 11:26:21 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 11:26:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:26:21 INFO - Return code: 0 11:26:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:26:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:26:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:26:21 INFO - ENV: RUST_BACKTRACE is now full 11:26:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:26:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:26:21 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/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 11:26:21 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/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 11:26:21 INFO - Using env: {'DISPLAY': ':0', 11:26:21 INFO - 'HOME': '/home/cltbld', 11:26:21 INFO - 'LANG': 'en_US.UTF-8', 11:26:21 INFO - 'LANGUAGE': 'en_US:en', 11:26:21 INFO - 'LOGNAME': 'cltbld', 11:26:21 INFO - 'MAIL': '/var/mail/cltbld', 11:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:21 INFO - 'MOZ_ACCELERATED': '1', 11:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:21 INFO - 'MOZ_NO_REMOTE': '1', 11:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:21 INFO - 'MOZ_WEBRENDER': '1', 11:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:21 INFO - 'NO_EM_RESTART': '1', 11:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:21 INFO - 'PWD': '/builds/slave/test', 11:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:21 INFO - 'RUST_BACKTRACE': 'full', 11:26:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:21 INFO - 'SHELL': '/bin/bash', 11:26:21 INFO - 'SHLVL': '1', 11:26:21 INFO - 'TERM': 'linux', 11:26:21 INFO - 'TMOUT': '86400', 11:26:21 INFO - 'USER': 'cltbld', 11:26:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:21 INFO - '_': '/tools/buildbot/bin/python'} 11:26:21 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/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 11:26:21 INFO - mozversion application_buildid: 20170905173605 11:26:21 INFO - mozversion application_changeset: 973e8b890a62aee4b3170558ac3b608928162ef6 11:26:21 INFO - mozversion application_display_name: Nightly 11:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:26:21 INFO - mozversion application_name: Firefox 11:26:21 INFO - mozversion application_remotingname: firefox 11:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:26:21 INFO - mozversion application_vendor: Mozilla 11:26:21 INFO - mozversion application_version: 57.0a1 11:26:21 INFO - mozversion platform_buildid: 20170905173605 11:26:21 INFO - mozversion platform_changeset: 973e8b890a62aee4b3170558ac3b608928162ef6 11:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:26:21 INFO - mozversion platform_version: 57.0a1 11:26:21 INFO - using testdate: 1504635981 11:26:21 INFO - actual date: 1504635981 11:26:21 INFO - starting webserver on 'localhost:39100' 11:26:21 INFO - SUITE-START | Running 2 tests 11:26:21 INFO - TEST-START | dromaeo_css 11:26:21 INFO - Initialising browser for dromaeo_css test... 11:26:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39100/getInfo.html -profile /tmp/tmpPCnAJb/profile 11:26:21 INFO - TEST-INFO | started process 22516 (/builds/slave/test/build/application/firefox/firefox http://localhost:39100/getInfo.html) 11:26:29 INFO - TEST-INFO | 22516: exit 0 11:26:29 INFO - Browser initialized. 11:26:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:26:29 INFO - Using env: {'DISPLAY': ':0', 11:26:29 INFO - 'HOME': '/home/cltbld', 11:26:29 INFO - 'JSGC_DISABLE_POISONING': '1', 11:26:29 INFO - 'LANG': 'en_US.UTF-8', 11:26:29 INFO - 'LANGUAGE': 'en_US:en', 11:26:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:26:29 INFO - 'LOGNAME': 'cltbld', 11:26:29 INFO - 'MAIL': '/var/mail/cltbld', 11:26:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:26:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:26:29 INFO - 'MOZ_ACCELERATED': '1', 11:26:29 INFO - 'MOZ_CRASHREPORTER': '1', 11:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:26:29 INFO - 'MOZ_NO_REMOTE': '1', 11:26:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:26:29 INFO - 'MOZ_WEBRENDER': '1', 11:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:29 INFO - 'NO_EM_RESTART': '1', 11:26:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:29 INFO - 'PWD': '/builds/slave/test', 11:26:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:26:29 INFO - 'RUST_BACKTRACE': 'full', 11:26:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:26:29 INFO - 'SHELL': '/bin/bash', 11:26:29 INFO - 'SHLVL': '1', 11:26:29 INFO - 'TERM': 'linux', 11:26:29 INFO - 'TMOUT': '86400', 11:26:29 INFO - 'USER': 'cltbld', 11:26:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:29 INFO - '_': '/tools/buildbot/bin/python'} 11:26:29 INFO - TEST-INFO | started process 22713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPCnAJb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:30 INFO - PID 22713 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:26:30 INFO - PID 22713 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:26:30 INFO - PID 22713 | 11:26:30 INFO - PID 22713 | (/builds/slave/test/build/application/firefox/firefox:22776): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:26:30 INFO - PID 22713 | 11:26:40 INFO - PID 22713 | RSS: Main: 203251712 11:26:40 INFO - PID 22713 | 11:26:44 INFO - PID 22713 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:29:39 INFO - PID 22713 | Cycle 1(1): loaded http://localhost:39100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39100/tests/dromaeo/cssquery-ext.html) 11:29:41 INFO - PID 22713 | RSS: Main: 218005504 11:29:41 INFO - PID 22713 | 11:32:44 INFO - PID 22713 | Cycle 1(1): loaded http://localhost:39100/tests/dromaeo/cssquery-ext.html (next: http://localhost:39100/tests/dromaeo/cssquery-jquery.html) 11:32:44 INFO - PID 22713 | RSS: Main: 215146496 11:32:44 INFO - PID 22713 | 11:35:46 INFO - PID 22713 | Cycle 1(1): loaded http://localhost:39100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39100/tests/dromaeo/cssquery-mootools.html) 11:35:47 INFO - PID 22713 | RSS: Main: 217395200 11:35:47 INFO - PID 22713 | 11:38:49 INFO - PID 22713 | Cycle 1(1): loaded http://localhost:39100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39100/tests/dromaeo/cssquery-prototype.html) 11:38:49 INFO - PID 22713 | RSS: Main: 216113152 11:38:49 INFO - PID 22713 | 11:41:53 INFO - PID 22713 | Cycle 1(1): loaded http://localhost:39100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39100/tests/dromaeo/cssquery-yui.html) 11:41:54 INFO - PID 22713 | RSS: Main: 219553792 11:41:54 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | Cycle 1(1): loaded http://localhost:39100/tests/dromaeo/cssquery-yui.html (next: http://localhost:39100/tests/dromaeo/cssquery-dojo.html) 11:44:56 INFO - PID 22713 | RSS: Main: 222150656 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | __start_tp_report 11:44:56 INFO - PID 22713 | _x_x_mozilla_page_load 11:44:56 INFO - PID 22713 | _x_x_mozilla_page_load_details 11:44:56 INFO - PID 22713 | |i|pagename|runs| 11:44:56 INFO - PID 22713 | |0;dojo.html;3254.495553189255;3330.400527904976;3362.7309815214785;3376.932461350773;3403.3703764803513;6425.5180861435465;6429.485641148714;6480.3519648035235;6483.286838447767;6510.96744516278;6303.810885673425;6383.553151279412;6409.807705768822;6425.903611445832;6431.774887878925;5857.736401861926;5864.3256025557075;5872.559558033143;5897.115432685088;5897.705114744267;5880.764769409218;5923.851903702399;5938.792142275021;5955.702214889238;5967.462928336449;5927.614705044159;5944.346121926585;5984;6020.939790602081;6036.96981515094;5869.8239052828485;5895.086261629454;5947.762089516415;5954.31525374581;5967.283925928895;5682.204491371212;5811.941880581225;5835.912461313042;5923.259592550931;5942.286925568917;6364.140840986453;6375.139356186948;6458.095866578683;6465.191851018622;6526.575772574767;6853.348931851466;6863.588184708883;6874.518783685144;6957.095577574883;6978.895316570255;6884.51808373414;6903.344182302673;6942.444604431684;6948.6525673716615;6954.687039083254;6411.974084146561;6415.67921603918;6422.133012043408;6480.449161821204;6494.155759751202;7028.05121308627;7094.290570942968;7156.82107947295;7188.928110718931;7191.280871912767;6683.532152749358;6813.080234168423;6860.622665753332;6878.8624227516175;6904.067950826675;6693.062971184038;6798.184217893884;6803.115594972622;6807.081044059088;6808.6936087876165;6655.46756259498;6705.865882682417;6734.158230221223;6765.729370825112;6778.423833974069;6787.592744435349;6818.2159051708695;6839.487038472035;6843.828904277333;6846.828829279308;5346.759395827197;5348.545373643284;5355.866103347447;5364.8122315718765;5379.408265090837;4673.392458980379;4713.811447542129;4747.169245382113;4760.95239047612;4766.571008609172;5850.619709718854;5947.524198064145;5991.7603295867675;6050.152978583002;6058;6830.487713421513;6832.487563432763;6976.7209311627985;7012.088428504262;7042.190148132928;5898.026825573732;5913.970430147908;5939.46544810969;6007.27912650476;6026.246719160105;5925.851853703692;5943.791967281124;5953.642781433041;5956.493698035715;5959.135925290895;6685.866282674319;6711;6757.831054223684;6757.898631520433;6759.357861003196;6857.108575885103;6926.376626103674;6993.790186294419;7000.789976300719;7006.299370062953;6611.801645950629;6639.800805975829;6647.302033286629;6747.089142965637;6748.426383757239;6593.538452308292;6724.798256052326;6760.256371799196;6786.253512113565;6867.278935711678;6914.688839002157;7040.929590704028;7044.647767611701;7051.435885129074;7059.788206353817;6684.097646817618;6690.966545167243;6703.865922681422;6777.661116944035;6785.948178032413;6566.540342176002;6667.233268174222;6693.732250709917;6784;6798.592084474947;6476.805695829133;6564.704588293443;6574.737010519526;6597.406233439014;6611.636360000246;6574.243961944438;6580.605163690194;6652.068710380454;6655.168103987002;6693.531452798257;6470.547061705635;6472.935270647422;6489.286178520265;6546.639934803631;6563.278039415565 11:44:56 INFO - PID 22713 | |1;ext.html;771.7684694591621;843.4981186194215;862.1723145780055;865.2688478235889;1134.7049767060562;29406.41187176258;29856.552151717715;38880.41679374808;38949;39252.411213831816;39379.80310098453;39576.40635390471;39630.60369396312;39706.8014659927;39713.801430992804;7545.7358992435275;7588.317051465367;7693.269139431773;7695.422843286748;7704.036995375578;7506.587137707451;7625.618719064052;7631.389488840907;7634.045744281965;7637.15991240963;7402.518836275652;7634.770956871303;7663.616819159048;7688.730894418696;7694.884576731353;7508.62456877154;7597;7597.962010189969;7603.65783539742;7608.581528015957;7333.449991250677;7399.297066778648;7545.094588649343;7548.773536793905;7554.622268886588;36177.73377931786;36509.63490365115;36568.45147322792;36598.45102323467;36835.447468287995;3405.591329040506;3434.793912365266;3441.7590768646205;3447.293304872495;3474.6004209515977;29894.252643683863;29914.70085299141;29947.700522994928;30032.8498357509;30064.54903176454;5073.086844368012;5103.87240318995;5123.180291153398;5123.385193776733;5145.228215767627;185439;186634;186724;187514.06242968835;188268;45308.54691453043;45315;45517.08965820665;45574.54425455703;45672.77163614227;47880.76059619679;48206.27690584644;48234.51765482371;48282;48337;15579.376824927103;15691.607709807118;15830.44593439224;15837.920810395874;15859.286332115082;12834.422450989729;12980.415881285366;13132.277724725232;13138.605841824761;13145.934270328587;12207.816882746765;12322.32227227511;13768.724625507433;13880.722385552433;13980.881529477618;4202.831886724497;5549.334079910436;5741.483266505951;5779.3642699303045;5794.565407594448;983.3155485524558;985.2413641496008;994.5922171909482;996.2179688944289;999.8500224966168;22826.201082962016;23025.53948921012;23272.95271712777;23324.533509329718;23344;1074.4359211413914;1082.1126676125502;1086.2721976275914;1105.2815669814524;1107.0534692837668;11984.700382490508;12069.396530173457;12152.513899443924;12248.142630015991;12253.326067066397;236760;237377;237528;237559;237702;50274.74862625664;50601.49398505968;52924.735376322875;54074;54421.72789136029;1446.0528353928194;1451.310627451973;1452.2375752729902;1453.404104317246;1454.905431146972;26182.73817261803;26187.869060654575;26656.60015099814;26687;26701.599476007486;35024.64975350316;35084.47373289454;35276.647233527336;35375;35388.82305588455;212534;213432;213458;213720;215697;32248;32363.19092022718;32401;32733.34533309273;32833.179170520925;37924.24151516899;38801.417978730904;39125.80437097796;39186.216275674895;39236.6076339233;29971.70028299689;29977.250568735955;29993.55009674813;30112.397752045275;30129.397412052076;29528.261793454476;29532.852335738186;29707.405851883275;29940.70059299466;30003.69996300009;31854.203644908135;32982.175445614055;33107.172320692174;33278.5008224872;33557.83221083879;27618.723812761615;28547.14358569246;29123.417531649673;29238.70761292445;29449.55825662574;21685.891570542048;22392.09396905326;22558.661620075385;22562.435939101655;22708.432289192904 11:44:56 INFO - PID 22713 | |2;jquery.html;543.3127094225803;555.4528789142696;563.4984863471511;564.7402194990302;567.2852206220163;21714;22567.435814104654;22586.54826903461;22630.88684556579;22643.99999999996;23773;24962.75037249627;25951.22146335613;26192.476150476978;26301.605475917877;6393.552451328409;6535.411812936834;6553.901691474632;6556;6584.2098948126295;6116.541259405541;6298.118263443122;6440.935590644104;6453.709583068749;6460.515461340395;6375.521835862306;6383.904241436359;6414.807555773335;6425.261094974067;6447.065175549543;6363.777267795651;6379.266384365765;6428.678566071678;6437.549371544017;6443.742250309982;5887.411258874121;5975.880482390327;5978.521718262528;5980.192673989;5992.940070599326;29069;29386.55920161199;29883;29918.85040574805;30145.246368840733;2021.878687278768;2068.017691596495;2068.48287928018;2073.315805784088;2077.6468000439963;18688;18883.244670213175;18950.81049189504;18970.14634341458;19090.522736931547;2388.79695225906;2435.7320694723567;2454.914078007261;2506.586413241813;2510.79913606911;134187.32906335502;138457;139264.30367848199;139409;139827.30086349606;14749;14785.334659940328;14856.702865942836;15180.240987950558;15334.23328833554;23190.53618927612;23210.187643432735;23231.419214519436;23262.418439538807;23277.3016809496;10381.325213861075;10466.162706983423;10517.316374435637;10542.631007914839;10552.683419497427;9790.461524616214;9896.10935015852;9897.851532227023;9923.65267215644;9932.80134397308;8747.956260218658;8879.378443509022;8932.240759535382;9464.574094165779;9503.097205765442;2642.868201181606;2677.919662410131;2801.2716693659795;2811.4377124575167;2832.957505637417;964.8504481805331;988.5749127875083;995.8605795188679;1009.4094954451728;1012.7012531303136;18910.905445472683;19711.80288197128;19854.40436786899;19996;20305.695414568498;1058.3015209961388;1059.8463222832645;1069.561479793281;1069.6363236499471;1074.7904158689137;11190.545229120326;11218.326900386002;11297.943510282395;11314.717132071764;11335.603253886075;427701;438154;448461;451041;455592;109725;111668.44165779282;111795.44102279599;112204;113192.43403782928;1191.7199458127334;1210.6731182580654;1220.8229806677982;1226.687194765347;1236.2335352081586;17579.82420175782;17842.107894605477;18029.278828847226;18127.90936045311;18448;53978.46021539735;54927.72536137294;54968.72515637556;55989.72005139948;57147.42852571421;66778.66610666916;67256;68631;68951;69499.30500694929;14138.08102473336;14247.788937939977;14422.711545769236;14441.49454769078;14467.710645786814;22162.66755998629;22277.77722222822;22392.32823015312;22434.887825560767;22902.198423055113;17620.383286584907;17953.73069403986;18063.909680451514;18205;18333.54166145857;16251.349946002027;16273;16526.75209871877;16646.91676541658;17009.574760631083;18445.446636600922;18564.81435185631;18630.906845465684;18633.81366186321;18780.24879004879;14165.575032748622;14204.36080376365;14255.857441425453;14263.42946282137;14291;17969.281228751228;18044.097795110454;18065.638687226445;18325.541861453035;18392.172352244448 11:44:56 INFO - PID 22713 | |3;mootools.html;1297.7469393468273;1337.832770903637;1342.946282148714;1357.6605848537865;1367.9452821887126;14261.215633140186;14869.107853528769;15012.099274043552;15052.17213053283;15058.924705376485;14623.634409139777;15106.244687765622;15123.470678526253;15317;15345.232738363093;2715.5247831629486;2771.030139451186;2784.0812531864535;2784.777217822569;2786.178077467142;2673.2915777319026;2678.1965410376906;2719.8912043518235;2733.4533093381306;2764.875580598878;2803.2431243564224;2835.9007434739788;2846.203063142313;2847.6440444944383;2849.173739615509;2685.717999610032;2739.794515411352;2743.231895069384;2745.2450576091533;2754.807163498556;2699.1497678231294;2699.3116755227293;2738.4933787249224;2745.807793454459;2756.8621568921476;14599.854001459955;14920.477783277533;14923.104613723102;14923.403063877431;14931.776023359658;7971.20287971204;8256.009278886511;8256.958715206445;8257.504549727035;8261.586920653943;5399.62202645815;5456.281271399496;5556.749946252428;5656.66060036395;5727.627704199213;1836.7061270196705;1909.150428059514;1912.359359614517;2344.4878053655466;2468.9259322220364;26202.213933582025;26469.867650661818;26568.46863062747;26677.199684009316;26726.5991010135;6777.2545020047755;6932.549384290005;7009.859802803915;7062.128535937981;7109.075820143348;16673.91663041677;17331.30674772995;17383.91308043452;17488.387906423213;17498.562535936704;7820.178881217504;8060.677572897019;8107.878381824277;8112.878306825402;8112.959435202786;7341.59621220838;7459.291367320096;7491.587962662106;7514.549127052394;7526.962365188248;5255.973720131451;5290.550303224269;5376.8118115865755;5407.215953686693;5503.477169668875;1508.328793686799;1548.5973646851673;1557.7693622038462;1566.5143805420357;1571.8035245594301;863.3869952333788;871.4640496094983;890.2922176869275;896.2740180453853;899.8155378147464;7172.354488096096;7185.856282874313;7187.496875218789;7197.89203161953;7209.315115064061;670.5507310102146;694.3854688600524;697.10770214126;699.5068476723898;715.1561157833702;4358.128374325148;4983.327250821165;5011.348524691767;5017.046761115376;5255.63210575256;21200.575988480145;21642.134314627237;21648.35054948354;21976;22021.559568808854;21085.578288434146;21151.894240528698;21356.038978246015;21567.352979410643;21587.784122158893;11076.833847492295;11222.607208747655;11247.550097996153;11305.434728263719;11324.263922844988;7777.961110194413;7958.0052493438325;7994.36045116401;8030.799230019296;8068.394870384627;18162.45512634623;18514.722279166093;18789.154488047796;18853.90573047126;18932.810671893105;18498.907505462386;19304.13131409118;19356.12897419591;19374.70937935904;19404.126814293108;10750.408727520062;10977.615783447542;11050.502727377449;11062.115030797357;11113.388763618079;13863.029587928748;13910.791338130139;13931.791023134458;13948.093373930662;13959.581212563638;11299.774004519699;11568.652940411801;11766.294022358687;11785.233959792586;11922.642320730392;10877.401742904216;10962.123030157409;11030.724231894266;11030.779384412106;11036.282641628268;9877.111060004634;10019.348742331726;10088.243381746544;10097.343672661253;10120.696379108638;6743.696533656095;6758.189017317954;6778.356056174655;6819.829504262433;6839.863202736017;6986.371226589428;7021.824454388681;7027;7046.013558101768;7111 11:44:56 INFO - PID 22713 | |4;prototype.html;496.4377371951763;500.0323082505329;521.1817446608825;521.9138842091055;528.6933578524454;6300.432961033506;6314.589551679138;6319.936800631992;6357.427831495164;6375.872482550346;6035.51715862731;6290.874182516347;6293.622382657044;6298.874022519547;6324.9367506324925;5068.518490743373;5088.771005304751;5136.794528218876;5155.226715992593;5162.974185129069;5079.720615366154;5082.16144336186;5086.771095300702;5086.847394578169;5113.258577506259;4927;4978.502149785028;5027.321311622921;5072.4166720827025;5116.667416617908;4990.228468893527;5069;5078.746062696888;5105.591552675795;5113.872153196163;4514.751688657123;4517.322401639747;4553.2714765637675;4562.6121779648765;4563.0873825235085;6243.500519958392;6292;6296.433321001086;6303.117563541108;6310.305866354697;5789.334226563957;5803.767849286023;5848.122781582797;5856.121581762727;5881.470667639933;6642.601443913332;6659.467242620579;6662.93337066628;6691.799246022579;6761.256261811197;4889.1443997300685;4910.410750709938;4915.58217551505;4937.382827146606;4946.2333338332255;6855.314468553105;6941.305869413069;6984.371406573433;7007;7025.789226323219;5102.107131252016;5118.232265160182;5119.59043276537;5125.436202017775;5140.969317119717;5148.897022059537;5151.150060240094;5168.328117344721;5182.730231093331;5207.531322181022;5797.333306669702;5798;5802.042662960649;5805.171371018116;5814.738336774855;6679.9332006679315;6693.129893113962;6716.697748601325;6770.1537307836525;6833.384995350442;1664.7336426171996;1726.2577091850624;1775.9822401775816;1796.6406718656322;1801.2437873073648;1155.5320095361392;1191.773563023023;1221.2977537915556;1230.8553045667616;1237.9566715164926;5869.092544922917;5873.500752436005;5900.557458190653;5925.933332000282;5957.702114894238;6683.532152749261;6791.422729068085;6807.3873351398615;6809.0467334573195;6865.862682746317;5688.260526131659;5812.796552120655;5878.412158784087;5909.940900591025;5954.940450595525;3602.2975519773395;3671.7980511071614;3682.9079273018388;3700.833462494194;3732.533433320835;6564.67176641166;6612.338766123446;6631.668416579152;6645.269020407752;6738.427233685192;7031.507794454441;7109.822254443577;7112.857742845114;7149.428045756327;7233.565986040854;6490.403838464652;6655.600663960178;6669.599824010575;6675.530053880096;6710.530262881552;6823.420009299265;6868.313168683092;6928.757493487704;6933.908993693543;6941.271166527442;6751.3923746861055;6787.5406787540915;6795.898061528982;6815.897761533482;6880.65596720172;6488.188976377953;6580;6688.264290927897;6697.330266973264;6710.966445167743;5005;5015.423226329019;5030.90599281432;5041.294218809443;5071.467495912876;6811.489138314745;6826.556273842184;6853.383195512428;6854.9657251713425;6916.135483064617;6671.733130674913;6673.232578253563;6690.966545167243;6735.595864248161;6736.663166841737;6637.767678131242;6701.128853249242;6704.765333213314;6729.360710732472;6768.56004359715;6264.843378915563;6595.703193356407;6621.238557565749;6663.233728121328;6683.699233534406;6345.428911397997;6602.702878370581;6637.535372523877;6666.8666326723605;6669.433098186514;6415.582987105823;6448.516361272829;6478.821160351641;6532.41208291256;6544.5418820684 11:44:56 INFO - PID 22713 | |5;yui.html;886.5611522296464;889.6130183370234;902.2150728865888;903.0427746588613;907.3603109807584;19201.615967680656;20175.192992280292;20213.898930505362;20225.797742022576;22364.21725239617;20538.383848484533;21208;21424.464388390297;21456.678149827763;21458.57082858342;977.0815433492512;987.5457289646771;989.3717489394214;996.9651062212824;998.2662742883974;1008.8638033865408;1010.525053224983;1011.6964910526813;1012.2408193854609;1012.7822518158595;994.13510246086;1030.7938412317528;1031.520343040486;1032.3083534032216;1036.2487196782347;1008.9495525223746;1023.0230130225617;1023.3655133817044;1023.4780262066325;1025.1337619711333;754.1365136918253;755.0938873352;755.1165136789969;755.3730403764862;755.6448469219458;18417.81582184188;18889.7166542502;19009.809901900942;19059.523511912175;20422.489437764027;19331.4200573983;19361.419157425298;19983.80016199834;20140.093695783726;20187.798122018885;17252.13739313029;17503.12484375776;17526.561835954075;17526.912365438093;17546.824531754646;3759.7744135351695;3772.830222639988;3780.489633899416;3782.1868298315717;3789.8673546425744;130185;134178.3291083548;134818;134837.32581337128;135883;16185.271662775203;16246.83753162477;16507.91746041262;16773.91613041927;16831.579210519834;27157.91368345244;27970.440591188064;28118.2970425741;28124;28939.13182604483;7815.25755053269;8221.383396245306;8593.183647553473;8869.600867960957;8975.28197744179;4363.890902727458;4408.713433626804;4439.66702497314;4449.310356894686;4458.108378324348;5040.1179793535985;5075.061113693904;5107.87230319245;5168.431472538018;5187.974060129675;1083.6315652678127;1104.3870651788175;1116.4361997191365;1130.4065365683082;1130.7003644034337;677.7051982387677;689.7965100295424;714.610537257196;714.8141483214401;717.1931576975902;11867.76264474723;11873.346965916784;11953.940230298793;12249;13317.200967941955;703.802935178151;704.1901812915188;717.9174394944648;718.8849784034529;733.611186071383;5212.353287262804;5371.543418809445;5673.8297851064535;5829.562782791308;5907.966105931445;111743.44128279306;113297;114036;116036;119033.40483297702;100722;100867.49566252122;102396.97603023874;104492.47753761182;105135.47432262942;84742;85199.14800852037;86777.5661121703;87084.56457717672;89789.55105224432;10207.285490015627;10252.23108266868;10253.436061016417;10355.378677279386;10388.844167337345;42307.1538569233;42685.089441372416;42714.57285427106;43655.34516982184;43745.78127109471;51809.740951295;52043.47956520538;52555.47444525659;53479;53484.19773703475;15730.370785168923;15741.921290393475;15807.68384632324;18582.907085464485;19422;19834.80165198387;20239.392818215478;20379.898100509403;20594.38216853497;20711.68932465984;18847.623047539248;19094.522636934187;19453.51366215856;19504.24461798445;19524.707129392787;18550;18604.81395186085;18605.2557897688;18739.531511712317;18876.33932812345;17729.645407091528;18173.54566135857;18878.05609719536;19100.23599056022;19677.704834427208;12569.622911312676;13014.15407998515;13870;14107.576772696835;14158.150510969375;13507.459701612219;14634.560963171121;14775.408983640535;15289;15433.151176685391 11:44:56 INFO - PID 22713 | __end_tp_report 11:44:56 INFO - PID 22713 | __start_cc_report 11:44:56 INFO - PID 22713 | _x_x_mozilla_cycle_collect,368 11:44:56 INFO - PID 22713 | __end_cc_report 11:44:56 INFO - PID 22713 | __startTimestamp1504637096869__endTimestamp 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | ------- Summary: start ------- 11:44:56 INFO - PID 22713 | Number of tests: 6 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | [#0] dojo.html Cycles:165 Average:6332.22 Median:6566.54 stddev:744.91 (11.3%) stddev-sans-first:706.99 11:44:56 INFO - PID 22713 | Values: 3254.5 3330.4 3362.7 3376.9 3403.4 6425.5 6429.5 6480.4 6483.3 6511.0 6303.8 6383.6 6409.8 6425.9 6431.8 5857.7 5864.3 5872.6 5897.1 5897.7 5880.8 5923.9 5938.8 5955.7 5967.5 5927.6 5944.3 5984.0 6020.9 6037.0 5869.8 5895.1 5947.8 5954.3 5967.3 5682.2 5811.9 5835.9 5923.3 5942.3 6364.1 6375.1 6458.1 6465.2 6526.6 6853.3 6863.6 6874.5 6957.1 6978.9 6884.5 6903.3 6942.4 6948.7 6954.7 6412.0 6415.7 6422.1 6480.4 6494.2 7028.1 7094.3 7156.8 7188.9 7191.3 6683.5 6813.1 6860.6 6878.9 6904.1 6693.1 6798.2 6803.1 6807.1 6808.7 6655.5 6705.9 6734.2 6765.7 6778.4 6787.6 6818.2 6839.5 6843.8 6846.8 5346.8 5348.5 5355.9 5364.8 5379.4 4673.4 4713.8 4747.2 4761.0 4766.6 5850.6 5947.5 5991.8 6050.2 6058.0 6830.5 6832.5 6976.7 7012.1 7042.2 5898.0 5914.0 5939.5 6007.3 6026.2 5925.9 5943.8 5953.6 5956.5 5959.1 6685.9 6711.0 6757.8 6757.9 6759.4 6857.1 6926.4 6993.8 7000.8 7006.3 6611.8 6639.8 6647.3 6747.1 6748.4 6593.5 6724.8 6760.3 6786.3 6867.3 6914.7 7040.9 7044.6 7051.4 7059.8 6684.1 6691.0 6703.9 6777.7 6785.9 6566.5 6667.2 6693.7 6784.0 6798.6 6476.8 6564.7 6574.7 6597.4 6611.6 6574.2 6580.6 6652.1 6655.2 6693.5 6470.5 6472.9 6489.3 6546.6 6563.3 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | [#1] ext.html Cycles:180 Average:37117.63 Median:33192.84 stddev:55419.90 (167.0%) stddev-sans-first:55508.17 11:44:56 INFO - PID 22713 | Values: 771.8 843.5 862.2 865.3 1134.7 29406.4 29856.6 38880.4 38949.0 39252.4 39379.8 39576.4 39630.6 39706.8 39713.8 7545.7 7588.3 7693.3 7695.4 7704.0 7506.6 7625.6 7631.4 7634.0 7637.2 7402.5 7634.8 7663.6 7688.7 7694.9 7508.6 7597.0 7598.0 7603.7 7608.6 7333.4 7399.3 7545.1 7548.8 7554.6 36177.7 36509.6 36568.5 36598.5 36835.4 3405.6 3434.8 3441.8 3447.3 3474.6 29894.3 29914.7 29947.7 30032.8 30064.5 5073.1 5103.9 5123.2 5123.4 5145.2 185439.0 186634.0 186724.0 187514.1 188268.0 45308.5 45315.0 45517.1 45574.5 45672.8 47880.8 48206.3 48234.5 48282.0 48337.0 15579.4 15691.6 15830.4 15837.9 15859.3 12834.4 12980.4 13132.3 13138.6 13145.9 12207.8 12322.3 13768.7 13880.7 13980.9 4202.8 5549.3 5741.5 5779.4 5794.6 983.3 985.2 994.6 996.2 999.9 22826.2 23025.5 23273.0 23324.5 23344.0 1074.4 1082.1 1086.3 1105.3 1107.1 11984.7 12069.4 12152.5 12248.1 12253.3 236760.0 237377.0 237528.0 237559.0 237702.0 50274.7 50601.5 52924.7 54074.0 54421.7 1446.1 1451.3 1452.2 1453.4 1454.9 26182.7 26187.9 26656.6 26687.0 26701.6 35024.6 35084.5 35276.6 35375.0 35388.8 212534.0 213432.0 213458.0 213720.0 215697.0 32248.0 32363.2 32401.0 32733.3 32833.2 37924.2 38801.4 39125.8 39186.2 39236.6 29971.7 29977.3 29993.6 30112.4 30129.4 29528.3 29532.9 29707.4 29940.7 30003.7 31854.2 32982.2 33107.2 33278.5 33557.8 27618.7 28547.1 29123.4 29238.7 29449.6 21685.9 22392.1 22558.7 22562.4 22708.4 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | [#2] jquery.html Cycles:180 Average:33224.74 Median:22413.61 stddev:75428.31 (336.5%) stddev-sans-first:75600.00 11:44:56 INFO - PID 22713 | Values: 543.3 555.5 563.5 564.7 567.3 21714.0 22567.4 22586.5 22630.9 22644.0 23773.0 24962.8 25951.2 26192.5 26301.6 6393.6 6535.4 6553.9 6556.0 6584.2 6116.5 6298.1 6440.9 6453.7 6460.5 6375.5 6383.9 6414.8 6425.3 6447.1 6363.8 6379.3 6428.7 6437.5 6443.7 5887.4 5975.9 5978.5 5980.2 5992.9 29069.0 29386.6 29883.0 29918.9 30145.2 2021.9 2068.0 2068.5 2073.3 2077.6 18688.0 18883.2 18950.8 18970.1 19090.5 2388.8 2435.7 2454.9 2506.6 2510.8 134187.3 138457.0 139264.3 139409.0 139827.3 14749.0 14785.3 14856.7 15180.2 15334.2 23190.5 23210.2 23231.4 23262.4 23277.3 10381.3 10466.2 10517.3 10542.6 10552.7 9790.5 9896.1 9897.9 9923.7 9932.8 8748.0 8879.4 8932.2 9464.6 9503.1 2642.9 2677.9 2801.3 2811.4 2833.0 964.9 988.6 995.9 1009.4 1012.7 18910.9 19711.8 19854.4 19996.0 20305.7 1058.3 1059.8 1069.6 1069.6 1074.8 11190.5 11218.3 11297.9 11314.7 11335.6 427701.0 438154.0 448461.0 451041.0 455592.0 109725.0 111668.4 111795.4 112204.0 113192.4 1191.7 1210.7 1220.8 1226.7 1236.2 17579.8 17842.1 18029.3 18127.9 18448.0 53978.5 54927.7 54968.7 55989.7 57147.4 66778.7 67256.0 68631.0 68951.0 69499.3 14138.1 14247.8 14422.7 14441.5 14467.7 22162.7 22277.8 22392.3 22434.9 22902.2 17620.4 17953.7 18063.9 18205.0 18333.5 16251.3 16273.0 16526.8 16646.9 17009.6 18445.4 18564.8 18630.9 18633.8 18780.2 14165.6 14204.4 14255.9 14263.4 14291.0 17969.3 18044.1 18065.6 18325.5 18392.2 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | [#3] mootools.html Cycles:180 Average:9283.81 Median:2681.96 stddev:6664.28 (248.5%) stddev-sans-first:6655.96 11:44:56 INFO - PID 22713 | Values: 1297.7 1337.8 1342.9 1357.7 1367.9 14261.2 14869.1 15012.1 15052.2 15058.9 14623.6 15106.2 15123.5 15317.0 15345.2 2715.5 2771.0 2784.1 2784.8 2786.2 2673.3 2678.2 2719.9 2733.5 2764.9 2803.2 2835.9 2846.2 2847.6 2849.2 2685.7 2739.8 2743.2 2745.2 2754.8 2699.1 2699.3 2738.5 2745.8 2756.9 14599.9 14920.5 14923.1 14923.4 14931.8 7971.2 8256.0 8257.0 8257.5 8261.6 5399.6 5456.3 5556.7 5656.7 5727.6 1836.7 1909.2 1912.4 2344.5 2468.9 26202.2 26469.9 26568.5 26677.2 26726.6 6777.3 6932.5 7009.9 7062.1 7109.1 16673.9 17331.3 17383.9 17488.4 17498.6 7820.2 8060.7 8107.9 8112.9 8113.0 7341.6 7459.3 7491.6 7514.5 7527.0 5256.0 5290.6 5376.8 5407.2 5503.5 1508.3 1548.6 1557.8 1566.5 1571.8 863.4 871.5 890.3 896.3 899.8 7172.4 7185.9 7187.5 7197.9 7209.3 670.6 694.4 697.1 699.5 715.2 4358.1 4983.3 5011.3 5017.0 5255.6 21200.6 21642.1 21648.4 21976.0 22021.6 21085.6 21151.9 21356.0 21567.4 21587.8 11076.8 11222.6 11247.6 11305.4 11324.3 7778.0 7958.0 7994.4 8030.8 8068.4 18162.5 18514.7 18789.2 18853.9 18932.8 18498.9 19304.1 19356.1 19374.7 19404.1 10750.4 10977.6 11050.5 11062.1 11113.4 13863.0 13910.8 13931.8 13948.1 13959.6 11299.8 11568.7 11766.3 11785.2 11922.6 10877.4 10962.1 11030.7 11030.8 11036.3 9877.1 10019.3 10088.2 10097.3 10120.7 6743.7 6758.2 6778.4 6819.8 6839.9 6986.4 7021.8 7027.0 7046.0 7111.0 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | [#4] prototype.html Cycles:180 Average:5620.30 Median:6295.03 stddev:1585.65 (25.2%) stddev-sans-first:1542.75 11:44:56 INFO - PID 22713 | Values: 496.4 500.0 521.2 521.9 528.7 6300.4 6314.6 6319.9 6357.4 6375.9 6035.5 6290.9 6293.6 6298.9 6324.9 5068.5 5088.8 5136.8 5155.2 5163.0 5079.7 5082.2 5086.8 5086.8 5113.3 4927.0 4978.5 5027.3 5072.4 5116.7 4990.2 5069.0 5078.7 5105.6 5113.9 4514.8 4517.3 4553.3 4562.6 4563.1 6243.5 6292.0 6296.4 6303.1 6310.3 5789.3 5803.8 5848.1 5856.1 5881.5 6642.6 6659.5 6662.9 6691.8 6761.3 4889.1 4910.4 4915.6 4937.4 4946.2 6855.3 6941.3 6984.4 7007.0 7025.8 5102.1 5118.2 5119.6 5125.4 5141.0 5148.9 5151.2 5168.3 5182.7 5207.5 5797.3 5798.0 5802.0 5805.2 5814.7 6679.9 6693.1 6716.7 6770.2 6833.4 1664.7 1726.3 1776.0 1796.6 1801.2 1155.5 1191.8 1221.3 1230.9 1238.0 5869.1 5873.5 5900.6 5925.9 5957.7 6683.5 6791.4 6807.4 6809.0 6865.9 5688.3 5812.8 5878.4 5909.9 5954.9 3602.3 3671.8 3682.9 3700.8 3732.5 6564.7 6612.3 6631.7 6645.3 6738.4 7031.5 7109.8 7112.9 7149.4 7233.6 6490.4 6655.6 6669.6 6675.5 6710.5 6823.4 6868.3 6928.8 6933.9 6941.3 6751.4 6787.5 6795.9 6815.9 6880.7 6488.2 6580.0 6688.3 6697.3 6711.0 5005.0 5015.4 5030.9 5041.3 5071.5 6811.5 6826.6 6853.4 6855.0 6916.1 6671.7 6673.2 6691.0 6735.6 6736.7 6637.8 6701.1 6704.8 6729.4 6768.6 6264.8 6595.7 6621.2 6663.2 6683.7 6345.4 6602.7 6637.5 6666.9 6669.4 6415.6 6448.5 6478.8 6532.4 6544.5 11:44:56 INFO - PID 22713 | 11:44:56 INFO - PID 22713 | [#5] yui.html Cycles:180 Average:23809.50 Median:19756.25 stddev:33025.34 (167.2%) stddev-sans-first:33073.13 11:44:56 INFO - PID 22713 | Values: 886.6 889.6 902.2 903.0 907.4 19201.6 20175.2 20213.9 20225.8 22364.2 20538.4 21208.0 21424.5 21456.7 21458.6 977.1 987.5 989.4 997.0 998.3 1008.9 1010.5 1011.7 1012.2 1012.8 994.1 1030.8 1031.5 1032.3 1036.2 1008.9 1023.0 1023.4 1023.5 1025.1 754.1 755.1 755.1 755.4 755.6 18417.8 18889.7 19009.8 19059.5 20422.5 19331.4 19361.4 19983.8 20140.1 20187.8 17252.1 17503.1 17526.6 17526.9 17546.8 3759.8 3772.8 3780.5 3782.2 3789.9 130185.0 134178.3 134818.0 134837.3 135883.0 16185.3 16246.8 16507.9 16773.9 16831.6 27157.9 27970.4 28118.3 28124.0 28939.1 7815.3 8221.4 8593.2 8869.6 8975.3 4363.9 4408.7 4439.7 4449.3 4458.1 5040.1 5075.1 5107.9 5168.4 5188.0 1083.6 1104.4 1116.4 1130.4 1130.7 677.7 689.8 714.6 714.8 717.2 11867.8 11873.3 11953.9 12249.0 13317.2 703.8 704.2 717.9 718.9 733.6 5212.4 5371.5 5673.8 5829.6 5908.0 111743.4 113297.0 114036.0 116036.0 119033.4 100722.0 100867.5 102397.0 104492.5 105135.5 84742.0 85199.1 86777.6 87084.6 89789.6 10207.3 10252.2 10253.4 10355.4 10388.8 42307.2 42685.1 42714.6 43655.3 43745.8 51809.7 52043.5 52555.5 53479.0 53484.2 15730.4 15741.9 15807.7 18582.9 19422.0 19834.8 20239.4 20379.9 20594.4 20711.7 18847.6 19094.5 19453.5 19504.2 19524.7 18550.0 18604.8 18605.3 18739.5 18876.3 17729.6 18173.5 18878.1 19100.2 19677.7 12569.6 13014.2 13870.0 14107.6 14158.2 13507.5 14634.6 14775.4 15289.0 15433.2 11:44:56 INFO - PID 22713 | -------- Summary: end -------- 11:44:56 INFO - PID 22713 | 11:44:57 INFO - TEST-INFO | 22713: exit 0 11:44:57 INFO - TEST-OK | dromaeo_css | took 1116371ms 11:44:57 INFO - TEST-START | kraken 11:44:57 INFO - Initialising browser for kraken test... 11:44:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39100/getInfo.html -profile /tmp/tmphksd6O/profile 11:44:57 INFO - TEST-INFO | started process 23107 (/builds/slave/test/build/application/firefox/firefox http://localhost:39100/getInfo.html) 11:45:04 INFO - TEST-INFO | 23107: exit 0 11:45:04 INFO - Browser initialized. 11:45:04 INFO - Running cycle 1/1 for kraken test... 11:45:04 INFO - Using env: {'DISPLAY': ':0', 11:45:04 INFO - 'HOME': '/home/cltbld', 11:45:04 INFO - 'JSGC_DISABLE_POISONING': '1', 11:45:04 INFO - 'LANG': 'en_US.UTF-8', 11:45:04 INFO - 'LANGUAGE': 'en_US:en', 11:45:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:45:04 INFO - 'LOGNAME': 'cltbld', 11:45:04 INFO - 'MAIL': '/var/mail/cltbld', 11:45:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:04 INFO - 'MOZ_ACCELERATED': '1', 11:45:04 INFO - 'MOZ_CRASHREPORTER': '1', 11:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:45:04 INFO - 'MOZ_NO_REMOTE': '1', 11:45:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:04 INFO - 'MOZ_WEBRENDER': '1', 11:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:04 INFO - 'NO_EM_RESTART': '1', 11:45:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:04 INFO - 'PWD': '/builds/slave/test', 11:45:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:04 INFO - 'RUST_BACKTRACE': 'full', 11:45:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:45:04 INFO - 'SHELL': '/bin/bash', 11:45:04 INFO - 'SHLVL': '1', 11:45:04 INFO - 'TERM': 'linux', 11:45:04 INFO - 'TMOUT': '86400', 11:45:04 INFO - 'USER': 'cltbld', 11:45:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217', 11:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:04 INFO - '_': '/tools/buildbot/bin/python'} 11:45:04 INFO - TEST-INFO | started process 23302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphksd6O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:05 INFO - PID 23302 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:45:05 INFO - PID 23302 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:45:05 INFO - PID 23302 | 11:45:05 INFO - PID 23302 | (/builds/slave/test/build/application/firefox/firefox:23364): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:45:05 INFO - PID 23302 | 11:45:15 INFO - PID 23302 | RSS: Main: 202199040 11:45:15 INFO - PID 23302 | 11:45:18 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39100/tests/kraken/driver.html?testName=audio-beat-detection) 11:45:19 INFO - PID 23302 | RSS: Main: 208322560 11:45:19 INFO - PID 23302 | 11:45:19 INFO - PID 23302 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:45:22 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39100/tests/kraken/driver.html?testName=audio-dft) 11:45:22 INFO - PID 23302 | RSS: Main: 214683648 11:45:22 INFO - PID 23302 | 11:45:25 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39100/tests/kraken/driver.html?testName=audio-fft) 11:45:26 INFO - PID 23302 | RSS: Main: 208277504 11:45:26 INFO - PID 23302 | 11:45:28 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39100/tests/kraken/driver.html?testName=audio-oscillator) 11:45:29 INFO - PID 23302 | RSS: Main: 209387520 11:45:29 INFO - PID 23302 | 11:45:31 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:45:32 INFO - PID 23302 | RSS: Main: 209588224 11:45:32 INFO - PID 23302 | 11:45:35 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39100/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:35 INFO - PID 23302 | RSS: Main: 210354176 11:45:35 INFO - PID 23302 | 11:45:39 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39100/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:39 INFO - PID 23302 | RSS: Main: 210591744 11:45:39 INFO - PID 23302 | 11:45:42 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39100/tests/kraken/driver.html?testName=json-parse-financial) 11:45:43 INFO - PID 23302 | RSS: Main: 211202048 11:45:43 INFO - PID 23302 | 11:45:45 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:45 INFO - PID 23302 | RSS: Main: 211292160 11:45:45 INFO - PID 23302 | 11:45:47 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:48 INFO - PID 23302 | RSS: Main: 210681856 11:45:48 INFO - PID 23302 | 11:45:50 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:50 INFO - PID 23302 | RSS: Main: 211169280 11:45:50 INFO - PID 23302 | 11:45:53 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:54 INFO - PID 23302 | RSS: Main: 211808256 11:45:54 INFO - PID 23302 | 11:45:57 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:57 INFO - PID 23302 | RSS: Main: 212144128 11:45:57 INFO - PID 23302 | 11:45:59 INFO - PID 23302 | Cycle 1(1): loaded http://localhost:39100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39100/tests/kraken/driver.html?testName=ai-astar) 11:46:00 INFO - PID 23302 | RSS: Main: 213770240 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | __start_tp_report 11:46:00 INFO - PID 23302 | _x_x_mozilla_page_load 11:46:00 INFO - PID 23302 | _x_x_mozilla_page_load_details 11:46:00 INFO - PID 23302 | |i|pagename|runs| 11:46:00 INFO - PID 23302 | |0;ai-astar;100;108;101;112;112;118;107;104;110;115 11:46:00 INFO - PID 23302 | |1;audio-beat-detection;151;120;151;184;123;147;149;120;171;128 11:46:00 INFO - PID 23302 | |2;audio-dft;164;164;171;166;171;170;166;162;163;168 11:46:00 INFO - PID 23302 | |3;audio-fft;80;81;75;171;82;73;78;74;165;85 11:46:00 INFO - PID 23302 | |4;audio-oscillator;86;80;135;87;82;82;132;84;78;138 11:46:00 INFO - PID 23302 | |5;imaging-gaussian-blur;119;115;115;115;116;118;115;121;115;118 11:46:00 INFO - PID 23302 | |6;imaging-darkroom;149;150;148;149;155;148;150;147;159;157 11:46:00 INFO - PID 23302 | |7;imaging-desaturate;95;94;94;98;94;94;94;94;94;95 11:46:00 INFO - PID 23302 | |8;json-parse-financial;52;54;59;51;53;54;53;59;51;65 11:46:00 INFO - PID 23302 | |9;json-stringify-tinderbox;46;41;52;39;38;39;39;46;44;44 11:46:00 INFO - PID 23302 | |10;stanford-crypto-aes;76;80;78;82;80;80;78;75;79;75 11:46:00 INFO - PID 23302 | |11;stanford-crypto-ccm;134;125;130;121;128;121;134;117;122;171 11:46:00 INFO - PID 23302 | |12;stanford-crypto-pbkdf2;175;171;179;179;175;168;170;179;176;169 11:46:00 INFO - PID 23302 | |13;stanford-crypto-sha256-iterative;65;67;64;69;74;66;65;64;68;63 11:46:00 INFO - PID 23302 | __end_tp_report 11:46:00 INFO - PID 23302 | __start_cc_report 11:46:00 INFO - PID 23302 | _x_x_mozilla_cycle_collect,925 11:46:00 INFO - PID 23302 | __end_cc_report 11:46:00 INFO - PID 23302 | __startTimestamp1504637160017__endTimestamp 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | ------- Summary: start ------- 11:46:00 INFO - PID 23302 | Number of tests: 14 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:5.87 (5.3%) stddev-sans-first:5.32 11:46:00 INFO - PID 23302 | Values: 100.0 108.0 101.0 112.0 112.0 118.0 107.0 104.0 110.0 115.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:150.00 stddev:21.88 (14.6%) stddev-sans-first:23.08 11:46:00 INFO - PID 23302 | Values: 151.0 120.0 151.0 184.0 123.0 147.0 149.0 120.0 171.0 128.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#2] audio-dft Cycles:10 Average:166.50 Median:167.00 stddev:3.34 (2.0%) stddev-sans-first:3.42 11:46:00 INFO - PID 23302 | Values: 164.0 164.0 171.0 166.0 171.0 170.0 166.0 162.0 163.0 168.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#3] audio-fft Cycles:10 Average:96.40 Median:79.00 stddev:37.95 (48.0%) stddev-sans-first:39.78 11:46:00 INFO - PID 23302 | Values: 80.0 81.0 75.0 171.0 82.0 73.0 78.0 74.0 165.0 85.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:82.00 stddev:25.43 (31.0%) stddev-sans-first:26.57 11:46:00 INFO - PID 23302 | Values: 86.0 80.0 135.0 87.0 82.0 82.0 132.0 84.0 78.0 138.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:2.16 (1.8%) stddev-sans-first:2.13 11:46:00 INFO - PID 23302 | Values: 119.0 115.0 115.0 115.0 116.0 118.0 115.0 121.0 115.0 118.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:150.00 stddev:4.21 (2.8%) stddev-sans-first:4.39 11:46:00 INFO - PID 23302 | Values: 149.0 150.0 148.0 149.0 155.0 148.0 150.0 147.0 159.0 157.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 11:46:00 INFO - PID 23302 | Values: 95.0 94.0 94.0 98.0 94.0 94.0 94.0 94.0 94.0 95.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:4.51 (8.3%) stddev-sans-first:4.64 11:46:00 INFO - PID 23302 | Values: 52.0 54.0 59.0 51.0 53.0 54.0 53.0 59.0 51.0 65.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#9] json-stringify-tinderbox Cycles:10 Average:42.80 Median:44.00 stddev:4.44 (10.1%) stddev-sans-first:4.56 11:46:00 INFO - PID 23302 | Values: 46.0 41.0 52.0 39.0 38.0 39.0 39.0 46.0 44.0 44.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:79.50 stddev:2.36 (3.0%) stddev-sans-first:2.35 11:46:00 INFO - PID 23302 | Values: 76.0 80.0 78.0 82.0 80.0 80.0 78.0 75.0 79.0 75.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:129.00 stddev:15.41 (11.9%) stddev-sans-first:16.28 11:46:00 INFO - PID 23302 | Values: 134.0 125.0 130.0 121.0 128.0 121.0 134.0 117.0 122.0 171.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:175.50 stddev:4.31 (2.5%) stddev-sans-first:4.56 11:46:00 INFO - PID 23302 | Values: 175.0 171.0 179.0 179.0 175.0 168.0 170.0 179.0 176.0 169.0 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:3.24 (4.9%) stddev-sans-first:3.39 11:46:00 INFO - PID 23302 | Values: 65.0 67.0 64.0 69.0 74.0 66.0 65.0 64.0 68.0 63.0 11:46:00 INFO - PID 23302 | -------- Summary: end -------- 11:46:00 INFO - PID 23302 | 11:46:00 INFO - PID 23302 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:46:00 INFO - TEST-INFO | 23302: exit 0 11:46:00 INFO - TEST-OK | kraken | took 63094ms 11:46:00 INFO - SUITE-END | took 1179s 11:46:01 INFO - Completed test suite (00:19:39) 11:46:01 INFO - javascript benchmark 11:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8536.552895197332, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.495553189255, 3330.400527904976, 3362.7309815214785, 3376.932461350773, 3403.3703764803513, 6425.5180861435465, 6429.485641148714, 6480.3519648035235, 6483.286838447767, 6510.96744516278, 6303.810885673425, 6383.553151279412, 6409.807705768822, 6425.903611445832, 6431.774887878925, 5857.736401861926, 5864.3256025557075, 5872.559558033143, 5897.115432685088, 5897.705114744267, 5880.764769409218, 5923.851903702399, 5938.792142275021, 5955.702214889238, 5967.462928336449, 5927.614705044159, 5944.346121926585, 5984.0, 6020.939790602081, 6036.96981515094, 5869.8239052828485, 5895.086261629454, 5947.762089516415, 5954.31525374581, 5967.283925928895, 5682.204491371212, 5811.941880581225, 5835.912461313042, 5923.259592550931, 5942.286925568917, 6364.140840986453, 6375.139356186948, 6458.095866578683, 6465.191851018622, 6526.575772574767, 6853.348931851466, 6863.588184708883, 6874.518783685144, 6957.095577574883, 6978.895316570255, 6884.51808373414, 6903.344182302673, 6942.444604431684, 6948.6525673716615, 6954.687039083254, 6411.974084146561, 6415.67921603918, 6422.133012043408, 6480.449161821204, 6494.155759751202, 7028.05121308627, 7094.290570942968, 7156.82107947295, 7188.928110718931, 7191.280871912767, 6683.532152749358, 6813.080234168423, 6860.622665753332, 6878.8624227516175, 6904.067950826675, 6693.062971184038, 6798.184217893884, 6803.115594972622, 6807.081044059088, 6808.6936087876165, 6655.46756259498, 6705.865882682417, 6734.158230221223, 6765.729370825112, 6778.423833974069, 6787.592744435349, 6818.2159051708695, 6839.487038472035, 6843.828904277333, 6846.828829279308, 5346.759395827197, 5348.545373643284, 5355.866103347447, 5364.8122315718765, 5379.408265090837, 4673.392458980379, 4713.811447542129, 4747.169245382113, 4760.95239047612, 4766.571008609172, 5850.619709718854, 5947.524198064145, 5991.7603295867675, 6050.152978583002, 6058.0, 6830.487713421513, 6832.487563432763, 6976.7209311627985, 7012.088428504262, 7042.190148132928, 5898.026825573732, 5913.970430147908, 5939.46544810969, 6007.27912650476, 6026.246719160105, 5925.851853703692, 5943.791967281124, 5953.642781433041, 5956.493698035715, 5959.135925290895, 6685.866282674319, 6711.0, 6757.831054223684, 6757.898631520433, 6759.357861003196, 6857.108575885103, 6926.376626103674, 6993.790186294419, 7000.789976300719, 7006.299370062953, 6611.801645950629, 6639.800805975829, 6647.302033286629, 6747.089142965637, 6748.426383757239, 6593.538452308292, 6724.798256052326, 6760.256371799196, 6786.253512113565, 6867.278935711678, 6914.688839002157, 7040.929590704028, 7044.647767611701, 7051.435885129074, 7059.788206353817, 6684.097646817618, 6690.966545167243, 6703.865922681422, 6777.661116944035, 6785.948178032413, 6566.540342176002, 6667.233268174222, 6693.732250709917, 6784.0, 6798.592084474947, 6476.805695829133, 6564.704588293443, 6574.737010519526, 6597.406233439014, 6611.636360000246, 6574.243961944438, 6580.605163690194, 6652.068710380454, 6655.168103987002, 6693.531452798257, 6470.547061705635, 6472.935270647422, 6489.286178520265, 6546.639934803631, 6563.278039415565], "value": 6277.455308825255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.7684694591621, 843.4981186194215, 862.1723145780055, 865.2688478235889, 1134.7049767060562, 29406.41187176258, 29856.552151717715, 38880.41679374808, 38949.0, 39252.411213831816, 39379.80310098453, 39576.40635390471, 39630.60369396312, 39706.8014659927, 39713.801430992804, 7545.7358992435275, 7588.317051465367, 7693.269139431773, 7695.422843286748, 7704.036995375578, 7506.587137707451, 7625.618719064052, 7631.389488840907, 7634.045744281965, 7637.15991240963, 7402.518836275652, 7634.770956871303, 7663.616819159048, 7688.730894418696, 7694.884576731353, 7508.62456877154, 7597.0, 7597.962010189969, 7603.65783539742, 7608.581528015957, 7333.449991250677, 7399.297066778648, 7545.094588649343, 7548.773536793905, 7554.622268886588, 36177.73377931786, 36509.63490365115, 36568.45147322792, 36598.45102323467, 36835.447468287995, 3405.591329040506, 3434.793912365266, 3441.7590768646205, 3447.293304872495, 3474.6004209515977, 29894.252643683863, 29914.70085299141, 29947.700522994928, 30032.8498357509, 30064.54903176454, 5073.086844368012, 5103.87240318995, 5123.180291153398, 5123.385193776733, 5145.228215767627, 185439.0, 186634.0, 186724.0, 187514.06242968835, 188268.0, 45308.54691453043, 45315.0, 45517.08965820665, 45574.54425455703, 45672.77163614227, 47880.76059619679, 48206.27690584644, 48234.51765482371, 48282.0, 48337.0, 15579.376824927103, 15691.607709807118, 15830.44593439224, 15837.920810395874, 15859.286332115082, 12834.422450989729, 12980.415881285366, 13132.277724725232, 13138.605841824761, 13145.934270328587, 12207.816882746765, 12322.32227227511, 13768.724625507433, 13880.722385552433, 13980.881529477618, 4202.831886724497, 5549.334079910436, 5741.483266505951, 5779.3642699303045, 5794.565407594448, 983.3155485524558, 985.2413641496008, 994.5922171909482, 996.2179688944289, 999.8500224966168, 22826.201082962016, 23025.53948921012, 23272.95271712777, 23324.533509329718, 23344.0, 1074.4359211413914, 1082.1126676125502, 1086.2721976275914, 1105.2815669814524, 1107.0534692837668, 11984.700382490508, 12069.396530173457, 12152.513899443924, 12248.142630015991, 12253.326067066397, 236760.0, 237377.0, 237528.0, 237559.0, 237702.0, 50274.74862625664, 50601.49398505968, 52924.735376322875, 54074.0, 54421.72789136029, 1446.0528353928194, 1451.310627451973, 1452.2375752729902, 1453.404104317246, 1454.905431146972, 26182.73817261803, 26187.869060654575, 26656.60015099814, 26687.0, 26701.599476007486, 35024.64975350316, 35084.47373289454, 35276.647233527336, 35375.0, 35388.82305588455, 212534.0, 213432.0, 213458.0, 213720.0, 215697.0, 32248.0, 32363.19092022718, 32401.0, 32733.34533309273, 32833.179170520925, 37924.24151516899, 38801.417978730904, 39125.80437097796, 39186.216275674895, 39236.6076339233, 29971.70028299689, 29977.250568735955, 29993.55009674813, 30112.397752045275, 30129.397412052076, 29528.261793454476, 29532.852335738186, 29707.405851883275, 29940.70059299466, 30003.69996300009, 31854.203644908135, 32982.175445614055, 33107.172320692174, 33278.5008224872, 33557.83221083879, 27618.723812761615, 28547.14358569246, 29123.417531649673, 29238.70761292445, 29449.55825662574, 21685.891570542048, 22392.09396905326, 22558.661620075385, 22562.435939101655, 22708.432289192904], "value": 16663.949994023675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3127094225803, 555.4528789142696, 563.4984863471511, 564.7402194990302, 567.2852206220163, 21714.0, 22567.435814104654, 22586.54826903461, 22630.88684556579, 22643.99999999996, 23773.0, 24962.75037249627, 25951.22146335613, 26192.476150476978, 26301.605475917877, 6393.552451328409, 6535.411812936834, 6553.901691474632, 6556.0, 6584.2098948126295, 6116.541259405541, 6298.118263443122, 6440.935590644104, 6453.709583068749, 6460.515461340395, 6375.521835862306, 6383.904241436359, 6414.807555773335, 6425.261094974067, 6447.065175549543, 6363.777267795651, 6379.266384365765, 6428.678566071678, 6437.549371544017, 6443.742250309982, 5887.411258874121, 5975.880482390327, 5978.521718262528, 5980.192673989, 5992.940070599326, 29069.0, 29386.55920161199, 29883.0, 29918.85040574805, 30145.246368840733, 2021.878687278768, 2068.017691596495, 2068.48287928018, 2073.315805784088, 2077.6468000439963, 18688.0, 18883.244670213175, 18950.81049189504, 18970.14634341458, 19090.522736931547, 2388.79695225906, 2435.7320694723567, 2454.914078007261, 2506.586413241813, 2510.79913606911, 134187.32906335502, 138457.0, 139264.30367848199, 139409.0, 139827.30086349606, 14749.0, 14785.334659940328, 14856.702865942836, 15180.240987950558, 15334.23328833554, 23190.53618927612, 23210.187643432735, 23231.419214519436, 23262.418439538807, 23277.3016809496, 10381.325213861075, 10466.162706983423, 10517.316374435637, 10542.631007914839, 10552.683419497427, 9790.461524616214, 9896.10935015852, 9897.851532227023, 9923.65267215644, 9932.80134397308, 8747.956260218658, 8879.378443509022, 8932.240759535382, 9464.574094165779, 9503.097205765442, 2642.868201181606, 2677.919662410131, 2801.2716693659795, 2811.4377124575167, 2832.957505637417, 964.8504481805331, 988.5749127875083, 995.8605795188679, 1009.4094954451728, 1012.7012531303136, 18910.905445472683, 19711.80288197128, 19854.40436786899, 19996.0, 20305.695414568498, 1058.3015209961388, 1059.8463222832645, 1069.561479793281, 1069.6363236499471, 1074.7904158689137, 11190.545229120326, 11218.326900386002, 11297.943510282395, 11314.717132071764, 11335.603253886075, 427701.0, 438154.0, 448461.0, 451041.0, 455592.0, 109725.0, 111668.44165779282, 111795.44102279599, 112204.0, 113192.43403782928, 1191.7199458127334, 1210.6731182580654, 1220.8229806677982, 1226.687194765347, 1236.2335352081586, 17579.82420175782, 17842.107894605477, 18029.278828847226, 18127.90936045311, 18448.0, 53978.46021539735, 54927.72536137294, 54968.72515637556, 55989.72005139948, 57147.42852571421, 66778.66610666916, 67256.0, 68631.0, 68951.0, 69499.30500694929, 14138.08102473336, 14247.788937939977, 14422.711545769236, 14441.49454769078, 14467.710645786814, 22162.66755998629, 22277.77722222822, 22392.32823015312, 22434.887825560767, 22902.198423055113, 17620.383286584907, 17953.73069403986, 18063.909680451514, 18205.0, 18333.54166145857, 16251.349946002027, 16273.0, 16526.75209871877, 16646.91676541658, 17009.574760631083, 18445.446636600922, 18564.81435185631, 18630.906845465684, 18633.81366186321, 18780.24879004879, 14165.575032748622, 14204.36080376365, 14255.857441425453, 14263.42946282137, 14291.0, 17969.281228751228, 18044.097795110454, 18065.638687226445, 18325.541861453035, 18392.172352244448], "value": 11897.022576797674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.7469393468273, 1337.832770903637, 1342.946282148714, 1357.6605848537865, 1367.9452821887126, 14261.215633140186, 14869.107853528769, 15012.099274043552, 15052.17213053283, 15058.924705376485, 14623.634409139777, 15106.244687765622, 15123.470678526253, 15317.0, 15345.232738363093, 2715.5247831629486, 2771.030139451186, 2784.0812531864535, 2784.777217822569, 2786.178077467142, 2673.2915777319026, 2678.1965410376906, 2719.8912043518235, 2733.4533093381306, 2764.875580598878, 2803.2431243564224, 2835.9007434739788, 2846.203063142313, 2847.6440444944383, 2849.173739615509, 2685.717999610032, 2739.794515411352, 2743.231895069384, 2745.2450576091533, 2754.807163498556, 2699.1497678231294, 2699.3116755227293, 2738.4933787249224, 2745.807793454459, 2756.8621568921476, 14599.854001459955, 14920.477783277533, 14923.104613723102, 14923.403063877431, 14931.776023359658, 7971.20287971204, 8256.009278886511, 8256.958715206445, 8257.504549727035, 8261.586920653943, 5399.62202645815, 5456.281271399496, 5556.749946252428, 5656.66060036395, 5727.627704199213, 1836.7061270196705, 1909.150428059514, 1912.359359614517, 2344.4878053655466, 2468.9259322220364, 26202.213933582025, 26469.867650661818, 26568.46863062747, 26677.199684009316, 26726.5991010135, 6777.2545020047755, 6932.549384290005, 7009.859802803915, 7062.128535937981, 7109.075820143348, 16673.91663041677, 17331.30674772995, 17383.91308043452, 17488.387906423213, 17498.562535936704, 7820.178881217504, 8060.677572897019, 8107.878381824277, 8112.878306825402, 8112.959435202786, 7341.59621220838, 7459.291367320096, 7491.587962662106, 7514.549127052394, 7526.962365188248, 5255.973720131451, 5290.550303224269, 5376.8118115865755, 5407.215953686693, 5503.477169668875, 1508.328793686799, 1548.5973646851673, 1557.7693622038462, 1566.5143805420357, 1571.8035245594301, 863.3869952333788, 871.4640496094983, 890.2922176869275, 896.2740180453853, 899.8155378147464, 7172.354488096096, 7185.856282874313, 7187.496875218789, 7197.89203161953, 7209.315115064061, 670.5507310102146, 694.3854688600524, 697.10770214126, 699.5068476723898, 715.1561157833702, 4358.128374325148, 4983.327250821165, 5011.348524691767, 5017.046761115376, 5255.63210575256, 21200.575988480145, 21642.134314627237, 21648.35054948354, 21976.0, 22021.559568808854, 21085.578288434146, 21151.894240528698, 21356.038978246015, 21567.352979410643, 21587.784122158893, 11076.833847492295, 11222.607208747655, 11247.550097996153, 11305.434728263719, 11324.263922844988, 7777.961110194413, 7958.0052493438325, 7994.36045116401, 8030.799230019296, 8068.394870384627, 18162.45512634623, 18514.722279166093, 18789.154488047796, 18853.90573047126, 18932.810671893105, 18498.907505462386, 19304.13131409118, 19356.12897419591, 19374.70937935904, 19404.126814293108, 10750.408727520062, 10977.615783447542, 11050.502727377449, 11062.115030797357, 11113.388763618079, 13863.029587928748, 13910.791338130139, 13931.791023134458, 13948.093373930662, 13959.581212563638, 11299.774004519699, 11568.652940411801, 11766.294022358687, 11785.233959792586, 11922.642320730392, 10877.401742904216, 10962.123030157409, 11030.724231894266, 11030.779384412106, 11036.282641628268, 9877.111060004634, 10019.348742331726, 10088.243381746544, 10097.343672661253, 10120.696379108638, 6743.696533656095, 6758.189017317954, 6778.356056174655, 6819.829504262433, 6839.863202736017, 6986.371226589428, 7021.824454388681, 7027.0, 7046.013558101768, 7111.0], "value": 6606.674751389519, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.4377371951763, 500.0323082505329, 521.1817446608825, 521.9138842091055, 528.6933578524454, 6300.432961033506, 6314.589551679138, 6319.936800631992, 6357.427831495164, 6375.872482550346, 6035.51715862731, 6290.874182516347, 6293.622382657044, 6298.874022519547, 6324.9367506324925, 5068.518490743373, 5088.771005304751, 5136.794528218876, 5155.226715992593, 5162.974185129069, 5079.720615366154, 5082.16144336186, 5086.771095300702, 5086.847394578169, 5113.258577506259, 4927.0, 4978.502149785028, 5027.321311622921, 5072.4166720827025, 5116.667416617908, 4990.228468893527, 5069.0, 5078.746062696888, 5105.591552675795, 5113.872153196163, 4514.751688657123, 4517.322401639747, 4553.2714765637675, 4562.6121779648765, 4563.0873825235085, 6243.500519958392, 6292.0, 6296.433321001086, 6303.117563541108, 6310.305866354697, 5789.334226563957, 5803.767849286023, 5848.122781582797, 5856.121581762727, 5881.470667639933, 6642.601443913332, 6659.467242620579, 6662.93337066628, 6691.799246022579, 6761.256261811197, 4889.1443997300685, 4910.410750709938, 4915.58217551505, 4937.382827146606, 4946.2333338332255, 6855.314468553105, 6941.305869413069, 6984.371406573433, 7007.0, 7025.789226323219, 5102.107131252016, 5118.232265160182, 5119.59043276537, 5125.436202017775, 5140.969317119717, 5148.897022059537, 5151.150060240094, 5168.328117344721, 5182.730231093331, 5207.531322181022, 5797.333306669702, 5798.0, 5802.042662960649, 5805.171371018116, 5814.738336774855, 6679.9332006679315, 6693.129893113962, 6716.697748601325, 6770.1537307836525, 6833.384995350442, 1664.7336426171996, 1726.2577091850624, 1775.9822401775816, 1796.6406718656322, 1801.2437873073648, 1155.5320095361392, 1191.773563023023, 1221.2977537915556, 1230.8553045667616, 1237.9566715164926, 5869.092544922917, 5873.500752436005, 5900.557458190653, 5925.933332000282, 5957.702114894238, 6683.532152749261, 6791.422729068085, 6807.3873351398615, 6809.0467334573195, 6865.862682746317, 5688.260526131659, 5812.796552120655, 5878.412158784087, 5909.940900591025, 5954.940450595525, 3602.2975519773395, 3671.7980511071614, 3682.9079273018388, 3700.833462494194, 3732.533433320835, 6564.67176641166, 6612.338766123446, 6631.668416579152, 6645.269020407752, 6738.427233685192, 7031.507794454441, 7109.822254443577, 7112.857742845114, 7149.428045756327, 7233.565986040854, 6490.403838464652, 6655.600663960178, 6669.599824010575, 6675.530053880096, 6710.530262881552, 6823.420009299265, 6868.313168683092, 6928.757493487704, 6933.908993693543, 6941.271166527442, 6751.3923746861055, 6787.5406787540915, 6795.898061528982, 6815.897761533482, 6880.65596720172, 6488.188976377953, 6580.0, 6688.264290927897, 6697.330266973264, 6710.966445167743, 5005.0, 5015.423226329019, 5030.90599281432, 5041.294218809443, 5071.467495912876, 6811.489138314745, 6826.556273842184, 6853.383195512428, 6854.9657251713425, 6916.135483064617, 6671.733130674913, 6673.232578253563, 6690.966545167243, 6735.595864248161, 6736.663166841737, 6637.767678131242, 6701.128853249242, 6704.765333213314, 6729.360710732472, 6768.56004359715, 6264.843378915563, 6595.703193356407, 6621.238557565749, 6663.233728121328, 6683.699233534406, 6345.428911397997, 6602.702878370581, 6637.535372523877, 6666.8666326723605, 6669.433098186514, 6415.582987105823, 6448.516361272829, 6478.821160351641, 6532.41208291256, 6544.5418820684], "value": 5147.8645531799975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.5611522296464, 889.6130183370234, 902.2150728865888, 903.0427746588613, 907.3603109807584, 19201.615967680656, 20175.192992280292, 20213.898930505362, 20225.797742022576, 22364.21725239617, 20538.383848484533, 21208.0, 21424.464388390297, 21456.678149827763, 21458.57082858342, 977.0815433492512, 987.5457289646771, 989.3717489394214, 996.9651062212824, 998.2662742883974, 1008.8638033865408, 1010.525053224983, 1011.6964910526813, 1012.2408193854609, 1012.7822518158595, 994.13510246086, 1030.7938412317528, 1031.520343040486, 1032.3083534032216, 1036.2487196782347, 1008.9495525223746, 1023.0230130225617, 1023.3655133817044, 1023.4780262066325, 1025.1337619711333, 754.1365136918253, 755.0938873352, 755.1165136789969, 755.3730403764862, 755.6448469219458, 18417.81582184188, 18889.7166542502, 19009.809901900942, 19059.523511912175, 20422.489437764027, 19331.4200573983, 19361.419157425298, 19983.80016199834, 20140.093695783726, 20187.798122018885, 17252.13739313029, 17503.12484375776, 17526.561835954075, 17526.912365438093, 17546.824531754646, 3759.7744135351695, 3772.830222639988, 3780.489633899416, 3782.1868298315717, 3789.8673546425744, 130185.0, 134178.3291083548, 134818.0, 134837.32581337128, 135883.0, 16185.271662775203, 16246.83753162477, 16507.91746041262, 16773.91613041927, 16831.579210519834, 27157.91368345244, 27970.440591188064, 28118.2970425741, 28124.0, 28939.13182604483, 7815.25755053269, 8221.383396245306, 8593.183647553473, 8869.600867960957, 8975.28197744179, 4363.890902727458, 4408.713433626804, 4439.66702497314, 4449.310356894686, 4458.108378324348, 5040.1179793535985, 5075.061113693904, 5107.87230319245, 5168.431472538018, 5187.974060129675, 1083.6315652678127, 1104.3870651788175, 1116.4361997191365, 1130.4065365683082, 1130.7003644034337, 677.7051982387677, 689.7965100295424, 714.610537257196, 714.8141483214401, 717.1931576975902, 11867.76264474723, 11873.346965916784, 11953.940230298793, 12249.0, 13317.200967941955, 703.802935178151, 704.1901812915188, 717.9174394944648, 718.8849784034529, 733.611186071383, 5212.353287262804, 5371.543418809445, 5673.8297851064535, 5829.562782791308, 5907.966105931445, 111743.44128279306, 113297.0, 114036.0, 116036.0, 119033.40483297702, 100722.0, 100867.49566252122, 102396.97603023874, 104492.47753761182, 105135.47432262942, 84742.0, 85199.14800852037, 86777.5661121703, 87084.56457717672, 89789.55105224432, 10207.285490015627, 10252.23108266868, 10253.436061016417, 10355.378677279386, 10388.844167337345, 42307.1538569233, 42685.089441372416, 42714.57285427106, 43655.34516982184, 43745.78127109471, 51809.740951295, 52043.47956520538, 52555.47444525659, 53479.0, 53484.19773703475, 15730.370785168923, 15741.921290393475, 15807.68384632324, 18582.907085464485, 19422.0, 19834.80165198387, 20239.392818215478, 20379.898100509403, 20594.38216853497, 20711.68932465984, 18847.623047539248, 19094.522636934187, 19453.51366215856, 19504.24461798445, 19524.707129392787, 18550.0, 18604.81395186085, 18605.2557897688, 18739.531511712317, 18876.33932812345, 17729.645407091528, 18173.54566135857, 18878.05609719536, 19100.23599056022, 19677.704834427208, 12569.622911312676, 13014.15407998515, 13870.0, 14107.576772696835, 14158.150510969375, 13507.459701612219, 14634.560963171121, 14775.408983640535, 15289.0, 15433.151176685391], "value": 9142.420828640486, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 101.0, 112.0, 112.0, 118.0, 107.0, 104.0, 110.0, 115.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 151.0, 184.0, 123.0, 147.0, 149.0, 120.0, 171.0, 128.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 171.0, 166.0, 171.0, 170.0, 166.0, 162.0, 163.0, 168.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 75.0, 171.0, 82.0, 73.0, 78.0, 74.0, 165.0, 85.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 80.0, 135.0, 87.0, 82.0, 82.0, 132.0, 84.0, 78.0, 138.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 115.0, 115.0, 116.0, 118.0, 115.0, 121.0, 115.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 148.0, 149.0, 155.0, 148.0, 150.0, 147.0, 159.0, 157.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 59.0, 51.0, 53.0, 54.0, 53.0, 59.0, 51.0, 65.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 41.0, 52.0, 39.0, 38.0, 39.0, 39.0, 46.0, 44.0, 44.0], "value": 42.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 78.0, 82.0, 80.0, 80.0, 78.0, 75.0, 79.0, 75.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 125.0, 130.0, 121.0, 128.0, 121.0, 134.0, 117.0, 122.0, 171.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 179.0, 179.0, 175.0, 168.0, 170.0, 179.0, 176.0, 169.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 69.0, 74.0, 66.0, 65.0, 64.0, 68.0, 63.0], "value": 66.5, "unit": "score"}]}]} 11:46:01 INFO - Return code: 0 11:46:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:46:01 INFO - # TBPL SUCCESS # 11:46:01 INFO - Running post-action listener: _package_coverage_data 11:46:01 INFO - Running post-action listener: _resource_record_post_action 11:46:01 INFO - [mozharness: 2017-09-05 18:46:01.292198Z] Finished run-tests step (success) 11:46:01 INFO - Running post-run listener: _resource_record_post_run 11:46:01 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4513792; Write bytes: 391520256; Read time: 3200; Write time: 274524 11:46:01 INFO - TinderboxPrint: CPU usage
13.3% 11:46:01 INFO - TinderboxPrint: I/O read bytes / time
4,513,792 / 3,200 11:46:01 INFO - TinderboxPrint: I/O write bytes / time
391,520,256 / 274,524 11:46:01 INFO - TinderboxPrint: CPU idle
8,264.1 (86.7%) 11:46:01 INFO - TinderboxPrint: CPU user
1,202.9 (12.6%) 11:46:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:46:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106725376; Read time: 0; Write time: 81376 11:46:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:46:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4513792; Write bytes: 284794880; Read time: 3200; Write time: 193148 11:46:01 INFO - Running post-run listener: _upload_blobber_files 11:46:01 INFO - Blob upload gear active. 11:46:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:46:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:03 INFO - (blobuploader) - INFO - Done attempting. 11:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:46:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:10 INFO - (blobuploader) - INFO - Done attempting. 11:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:12 INFO - (blobuploader) - INFO - Done attempting. 11:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:13 INFO - (blobuploader) - INFO - Done attempting. 11:46:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:46:13 INFO - Return code: 0 11:46:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:46:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:46:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6c5ba51341f3b1ca625aa2f7359307605b610343c0391e024319779457c074b04133a4c6ddc7af8d295051a592f0222ec633a0ff375732a174af6c09c7d828", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1f5c255469fef81a36af90456ec6f3b842a954573d0f54891c1af22b36c2c9d80700110b4f107ec116bd21bab900b3794aa3a4691b2176b9e888a7c27f21273", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b90379fe18e972ccf203c81d30641a45f6425f5b920be47eb20f760c1c735c55250a8f9d6f482286e229dc0b580203c06dfb9bec63918882cd9459f0d8fe0e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81654501eb63fa255ca96bebe07629cfc1fa229475b6d9971bf9078abac4bdb24481250ab8d248f8d79880652436543330b9d2ecc4cefc68f6523d250c5590c7"} 11:46:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:46:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:46:13 INFO - Contents: 11:46:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6c5ba51341f3b1ca625aa2f7359307605b610343c0391e024319779457c074b04133a4c6ddc7af8d295051a592f0222ec633a0ff375732a174af6c09c7d828", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1f5c255469fef81a36af90456ec6f3b842a954573d0f54891c1af22b36c2c9d80700110b4f107ec116bd21bab900b3794aa3a4691b2176b9e888a7c27f21273", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b90379fe18e972ccf203c81d30641a45f6425f5b920be47eb20f760c1c735c55250a8f9d6f482286e229dc0b580203c06dfb9bec63918882cd9459f0d8fe0e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81654501eb63fa255ca96bebe07629cfc1fa229475b6d9971bf9078abac4bdb24481250ab8d248f8d79880652436543330b9d2ecc4cefc68f6523d250c5590c7"} 11:46:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:46:13 INFO - Copying logs to upload dir... 11:46:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:46:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.199646 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-09-05 11:46:13.625735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:13.631878) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6c5ba51341f3b1ca625aa2f7359307605b610343c0391e024319779457c074b04133a4c6ddc7af8d295051a592f0222ec633a0ff375732a174af6c09c7d828", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1f5c255469fef81a36af90456ec6f3b842a954573d0f54891c1af22b36c2c9d80700110b4f107ec116bd21bab900b3794aa3a4691b2176b9e888a7c27f21273", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b90379fe18e972ccf203c81d30641a45f6425f5b920be47eb20f760c1c735c55250a8f9d6f482286e229dc0b580203c06dfb9bec63918882cd9459f0d8fe0e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81654501eb63fa255ca96bebe07629cfc1fa229475b6d9971bf9078abac4bdb24481250ab8d248f8d79880652436543330b9d2ecc4cefc68f6523d250c5590c7"} build_url:https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/TJbnw1eAT3m2u_5HiPuYfA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f6c5ba51341f3b1ca625aa2f7359307605b610343c0391e024319779457c074b04133a4c6ddc7af8d295051a592f0222ec633a0ff375732a174af6c09c7d828", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1f5c255469fef81a36af90456ec6f3b842a954573d0f54891c1af22b36c2c9d80700110b4f107ec116bd21bab900b3794aa3a4691b2176b9e888a7c27f21273", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b90379fe18e972ccf203c81d30641a45f6425f5b920be47eb20f760c1c735c55250a8f9d6f482286e229dc0b580203c06dfb9bec63918882cd9459f0d8fe0e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81654501eb63fa255ca96bebe07629cfc1fa229475b6d9971bf9078abac4bdb24481250ab8d248f8d79880652436543330b9d2ecc4cefc68f6523d250c5590c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:13.662199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:13.662724) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1504633734.118478-654198217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-05 11:46:13.716372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 11:46:13.716693) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-05 11:46:13.716988) ========= ========= Total master_lag: 0.27 =========