builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-047 starttime: 1504431862.94 results: success (0) revision: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:22.936404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:22.936881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:22.937364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.010314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.010682) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-03 02:44:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.6M=0.001s 2017-09-03 02:44:23 (22.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093304 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.143751) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.144080) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024007 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.216075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:23.216437) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37824bf5c5b08afa7e689fceb935b8f457ebd9eb --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 37824bf5c5b08afa7e689fceb935b8f457ebd9eb --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=03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-03 02:44:23,260 truncating revision to first 12 chars 2017-09-03 02:44:23,260 Setting DEBUG logging. 2017-09-03 02:44:23,260 attempt 1/10 2017-09-03 02:44:23,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37824bf5c5b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-03 02:44:23,706 unpacking tar archive at: mozilla-central-37824bf5c5b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.052352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.052820) ========= script_repo_revision: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.053243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.053527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-03 02:44:24.072853) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-03 02:44:24.073255) ========= /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=03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:44:24 INFO - MultiFileLogger online at 20170903 02:44:24 in /builds/slave/test 02:44:24 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 02:44:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:24 INFO - {'append_to_log': False, 02:44:24 INFO - 'base_work_dir': '/builds/slave/test', 02:44:24 INFO - 'blob_upload_branch': 'Firefox', 02:44:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:24 INFO - 'branch': 'Firefox', 02:44:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:24 INFO - 'code_coverage': False, 02:44:24 INFO - 'config_files': ('talos/linux_config.py',), 02:44:24 INFO - 'default_actions': ('clobber', 02:44:24 INFO - 'read-buildbot-config', 02:44:24 INFO - 'download-and-extract', 02:44:24 INFO - 'populate-webroot', 02:44:24 INFO - 'create-virtualenv', 02:44:24 INFO - 'install', 02:44:24 INFO - 'setup-mitmproxy', 02:44:24 INFO - 'run-tests'), 02:44:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:24 INFO - 'disable_ccov_upload': False, 02:44:24 INFO - 'disable_stylo': False, 02:44:24 INFO - 'download_minidump_stackwalk': True, 02:44:24 INFO - 'download_symbols': 'ondemand', 02:44:24 INFO - 'enable_stylo': False, 02:44:24 INFO - 'enable_webrender': False, 02:44:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:44:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:24 INFO - 'gecko_profile': False, 02:44:24 INFO - 'gecko_profile_interval': 0, 02:44:24 INFO - 'installer_path': 'installer.exe', 02:44:24 INFO - 'log_level': 'info', 02:44:24 INFO - 'log_name': 'talos', 02:44:24 INFO - 'log_to_console': True, 02:44:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:44:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:44:24 INFO - 'opt_config_files': (), 02:44:24 INFO - 'pip_index': False, 02:44:24 INFO - 'suite': 'dromaeojs-e10s', 02:44:24 INFO - 'system_bits': '32', 02:44:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:24 INFO - 'title': 'talos-linux64-ix-047', 02:44:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:24 INFO - 'use_talos_json': True, 02:44:24 INFO - 'verify': 'False', 02:44:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:24 INFO - 'work_dir': 'build'} 02:44:24 INFO - [mozharness: 2017-09-03 09:44:24.261146Z] Running clobber step. 02:44:24 INFO - Running pre-action listener: _resource_record_pre_action 02:44:24 INFO - Running main action method: clobber 02:44:24 INFO - rmtree: /builds/slave/test/build 02:44:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:25 INFO - Running post-action listener: _resource_record_post_action 02:44:25 INFO - [mozharness: 2017-09-03 09:44:25.797404Z] Finished clobber step (success) 02:44:25 INFO - [mozharness: 2017-09-03 09:44:25.797503Z] Running read-buildbot-config step. 02:44:25 INFO - Running pre-action listener: _resource_record_pre_action 02:44:25 INFO - Running main action method: read_buildbot_config 02:44:25 INFO - Using buildbot properties: 02:44:25 INFO - { 02:44:25 INFO - "project": "", 02:44:25 INFO - "product": "firefox", 02:44:25 INFO - "who": "archaeopteryx@coole-files.de", 02:44:25 INFO - "installer_path": "public/build/target.tar.bz2", 02:44:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:44:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:44:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:44:25 INFO - "stage_platform": "linux64-stylo", 02:44:25 INFO - "basedir": "/builds/slave/test", 02:44:25 INFO - "buildnumber": 296, 02:44:25 INFO - "platform": "ubuntu64_hw_stylo", 02:44:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:44:25 INFO - "slavebuilddir": "test", 02:44:25 INFO - "taskId": "Q3CBn8_ZS-edEiWiERgveA", 02:44:25 INFO - "branch": "mozilla-central", 02:44:25 INFO - "script_repo_revision": "production", 02:44:25 INFO - "revision": "37824bf5c5b08afa7e689fceb935b8f457ebd9eb", 02:44:25 INFO - "slavename": "talos-linux64-ix-047", 02:44:25 INFO - "repo_path": "mozilla-central" 02:44:25 INFO - } 02:44:25 INFO - Finding installer, test and symbols from parent task. 02:44:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3CBn8_ZS-edEiWiERgveA'}, attempt #1 02:44:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3CBn8_ZS-edEiWiERgveA'}, attempt #1 02:44:26 INFO - Task dependencies: K9R3fxHzShCqGda311qAQg 02:44:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg'}, attempt #1 02:44:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json 02:44:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip 02:44:27 INFO - Running post-action listener: _resource_record_post_action 02:44:27 INFO - [mozharness: 2017-09-03 09:44:27.137159Z] Finished read-buildbot-config step (success) 02:44:27 INFO - [mozharness: 2017-09-03 09:44:27.137376Z] Running download-and-extract step. 02:44:27 INFO - Running pre-action listener: _resource_record_pre_action 02:44:27 INFO - Running main action method: download_and_extract 02:44:27 INFO - mkdir: /builds/slave/test/build/tests 02:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:27 INFO - trying https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json 02:44:27 INFO - Downloading https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:44:27 INFO - Downloaded 989 bytes. 02:44:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:44:27 INFO - Using the following test package requirements: 02:44:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:44:27 INFO - u'common': [u'target.common.tests.zip'], 02:44:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:44:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:44:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:44:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:44:27 INFO - u'mozbase': [u'target.common.tests.zip'], 02:44:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:44:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:44:27 INFO - u'web-platform': [u'target.common.tests.zip', 02:44:27 INFO - u'target.web-platform.tests.tar.gz'], 02:44:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:44:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:44:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip 02:44:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:27 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip into memory 02:44:29 INFO - Content-Length response header: 55022284 02:44:29 INFO - Bytes received: 55022284 02:44:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:44:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip 02:44:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:44:40 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.common.tests.zip into memory 02:44:41 INFO - Content-Length response header: 55022284 02:44:41 INFO - Bytes received: 55022284 02:44:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip 02:44:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:44:53 INFO - Fetch https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.talos.tests.zip into memory 02:44:55 INFO - Content-Length response header: 14496650 02:44:55 INFO - Bytes received: 14496650 02:44: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')]} 02:44:55 INFO - trying https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:55 INFO - Downloading https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:44:57 INFO - Downloaded 62653558 bytes. 02:44:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:57 INFO - mkdir: /builds/slave/test/properties 02:44:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:57 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:57 INFO - Contents: 02:44:57 INFO - build_url:https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 02:44:57 INFO - Running post-action listener: _resource_record_post_action 02:44:57 INFO - Running post-action listener: find_tests_for_verification 02:44:57 INFO - Running post-action listener: set_extra_try_arguments 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.500576Z] Finished download-and-extract step (success) 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.500677Z] Running populate-webroot step. 02:44:57 INFO - Running pre-action listener: _resource_record_pre_action 02:44:57 INFO - Running main action method: populate_webroot 02:44:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:57 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:57 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:57 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'tests': ['damp', 'tps']}, 02:44:57 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['damp', 'tps']}, 02:44:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:44:57 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:44:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:44:57 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:44:57 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:57 INFO - 'ts_paint', 02:44:57 INFO - 'tpaint', 02:44:57 INFO - 'sessionrestore', 02:44:57 INFO - 'sessionrestore_many_windows', 02:44:57 INFO - 'sessionrestore_no_auto_restore', 02:44:57 INFO - 'tabpaint']}, 02:44:57 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['a11yr', 02:44:57 INFO - 'ts_paint', 02:44:57 INFO - 'tpaint', 02:44:57 INFO - 'sessionrestore', 02:44:57 INFO - 'sessionrestore_many_windows', 02:44:57 INFO - 'sessionrestore_no_auto_restore', 02:44:57 INFO - 'tabpaint']}, 02:44:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:44:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:44:57 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['bloom_basic_singleton']}, 02:44:57 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['bloom_basic']}, 02:44:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:57 INFO - 'tsvgr_opacity', 02:44:57 INFO - 'tart', 02:44:57 INFO - 'tscrollx', 02:44:57 INFO - 'tsvg_static']}, 02:44:57 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tsvgx', 02:44:57 INFO - 'tsvgr_opacity', 02:44:57 INFO - 'tart', 02:44:57 INFO - 'tscrollx', 02:44:57 INFO - 'tsvg_static']}, 02:44:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:44:57 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo'], 02:44:57 INFO - 'tests': ['tp5o']}, 02:44:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:44:57 INFO - 'talos_options': ['--mitmproxy', 02:44:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:44:57 INFO - '--firstNonBlankPaint'], 02:44:57 INFO - 'tests': ['tp6_google', 02:44:57 INFO - 'tp6_youtube', 02:44:57 INFO - 'tp6_amazon', 02:44:57 INFO - 'tp6_facebook']}, 02:44:57 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo', 02:44:57 INFO - '--mitmproxy', 02:44:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:44:57 INFO - '--firstNonBlankPaint'], 02:44:57 INFO - 'tests': ['tp6_google', 02:44:57 INFO - 'tp6_youtube', 02:44:57 INFO - 'tp6_amazon', 02:44:57 INFO - 'tp6_facebook']}, 02:44:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo', 02:44:57 INFO - '--stylo-threads=1', 02:44:57 INFO - '--mitmproxy', 02:44:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:44:57 INFO - '--firstNonBlankPaint'], 02:44:57 INFO - 'tests': ['tp6_google', 02:44:57 INFO - 'tp6_youtube', 02:44:57 INFO - 'tp6_amazon', 02:44:57 INFO - 'tp6_facebook']}, 02:44:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--xperf_path', 02:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:57 INFO - 'tests': ['tp5n']}, 02:44:57 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 02:44:57 INFO - 'talos_options': ['--enable-stylo', 02:44:57 INFO - '--xperf_path', 02:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:57 INFO - 'tests': ['tp5n']}}} 02:44:57 INFO - Running post-action listener: _resource_record_post_action 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.514942Z] Finished populate-webroot step (success) 02:44:57 INFO - [mozharness: 2017-09-03 09:44:57.515032Z] Running create-virtualenv step. 02:44:57 INFO - Running pre-action listener: _resource_record_pre_action 02:44:57 INFO - Running main action method: create_virtualenv 02:44:57 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:57 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:44:57 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:44:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:44:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:58 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:58 INFO - Installing pip...............done. 02:44:58 INFO - Return code: 0 02:44:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:44:58 INFO - Reading from file tmpfile_stdout 02:44:58 INFO - Output received: 02:44:58 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:44:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44: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')]} 02:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:58 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:44:58 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 02:44:58 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 02:44:58 INFO - Using env: {'DISPLAY': ':0', 02:44:58 INFO - 'HOME': '/home/cltbld', 02:44:58 INFO - 'LANG': 'en_US.UTF-8', 02:44:58 INFO - 'LANGUAGE': 'en_US:en', 02:44:58 INFO - 'LOGNAME': 'cltbld', 02:44:58 INFO - 'MAIL': '/var/mail/cltbld', 02:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:58 INFO - 'MOZ_NO_REMOTE': '1', 02:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:58 INFO - 'NO_EM_RESTART': '1', 02:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:58 INFO - 'PWD': '/builds/slave/test', 02:44:58 INFO - 'SHELL': '/bin/bash', 02:44:58 INFO - 'SHLVL': '1', 02:44:58 INFO - 'TERM': 'linux', 02:44:58 INFO - 'TMOUT': '86400', 02:44:58 INFO - 'USER': 'cltbld', 02:44:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:58 INFO - '_': '/tools/buildbot/bin/python'} 02:44:59 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:44:59 INFO - Downloading/unpacking pip>=1.5 02:44:59 INFO - Running setup.py egg_info for package pip 02:44:59 INFO - warning: no files found matching 'pip/cacert.pem' 02:44:59 INFO - warning: no files found matching '*.html' under directory 'docs' 02:44:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:44:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:44:59 INFO - Installing collected packages: pip 02:44:59 INFO - Found existing installation: pip 1.1 02:44:59 INFO - Uninstalling pip: 02:44:59 INFO - Successfully uninstalled pip 02:44:59 INFO - Running setup.py install for pip 02:44:59 INFO - warning: no files found matching 'pip/cacert.pem' 02:44:59 INFO - warning: no files found matching '*.html' under directory 'docs' 02:44:59 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:44:59 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:44:59 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Successfully installed pip 02:44:59 INFO - Cleaning up... 02:44:59 INFO - Return code: 0 02:44:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:59 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:44:59 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 02:44:59 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 02:44:59 INFO - Using env: {'DISPLAY': ':0', 02:44:59 INFO - 'HOME': '/home/cltbld', 02:44:59 INFO - 'LANG': 'en_US.UTF-8', 02:44:59 INFO - 'LANGUAGE': 'en_US:en', 02:44:59 INFO - 'LOGNAME': 'cltbld', 02:44:59 INFO - 'MAIL': '/var/mail/cltbld', 02:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:59 INFO - 'MOZ_NO_REMOTE': '1', 02:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:44:59 INFO - 'NO_EM_RESTART': '1', 02:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:59 INFO - 'PWD': '/builds/slave/test', 02:44:59 INFO - 'SHELL': '/bin/bash', 02:44:59 INFO - 'SHLVL': '1', 02:44:59 INFO - 'TERM': 'linux', 02:44:59 INFO - 'TMOUT': '86400', 02:44:59 INFO - 'USER': 'cltbld', 02:44:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:59 INFO - '_': '/tools/buildbot/bin/python'} 02:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:59 INFO - Downloading/unpacking psutil>=3.1.1 02:44:59 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 02:44:59 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 02:44:59 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 02:44:59 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 02:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:01 INFO - Installing collected packages: psutil 02:45:01 INFO - Running setup.py install for psutil 02:45:01 INFO - building 'psutil._psutil_linux' extension 02:45:01 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 02:45:01 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 02:45:01 INFO - building 'psutil._psutil_posix' extension 02:45:01 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 02:45:01 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 02:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:01 INFO - Successfully installed psutil 02:45:01 INFO - Cleaning up... 02:45:01 INFO - Return code: 0 02:45:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:45:01 INFO - Using env: {'DISPLAY': ':0', 02:45:01 INFO - 'HOME': '/home/cltbld', 02:45:01 INFO - 'LANG': 'en_US.UTF-8', 02:45:01 INFO - 'LANGUAGE': 'en_US:en', 02:45:01 INFO - 'LOGNAME': 'cltbld', 02:45:01 INFO - 'MAIL': '/var/mail/cltbld', 02:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:01 INFO - 'MOZ_NO_REMOTE': '1', 02:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:01 INFO - 'NO_EM_RESTART': '1', 02:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:01 INFO - 'PWD': '/builds/slave/test', 02:45:01 INFO - 'SHELL': '/bin/bash', 02:45:01 INFO - 'SHLVL': '1', 02:45:01 INFO - 'TERM': 'linux', 02:45:01 INFO - 'TMOUT': '86400', 02:45:01 INFO - 'USER': 'cltbld', 02:45:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:01 INFO - '_': '/tools/buildbot/bin/python'} 02:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:45: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 02:45: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 02:45: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 02:45: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 02:45:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:45:03 INFO - Installing collected packages: mozsystemmonitor 02:45:03 INFO - Running setup.py install for mozsystemmonitor 02:45:03 INFO - Successfully installed mozsystemmonitor 02:45:03 INFO - Cleaning up... 02:45:03 INFO - Return code: 0 02:45:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:03 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:03 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 02:45:03 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 02:45:03 INFO - Using env: {'DISPLAY': ':0', 02:45:03 INFO - 'HOME': '/home/cltbld', 02:45:03 INFO - 'LANG': 'en_US.UTF-8', 02:45:03 INFO - 'LANGUAGE': 'en_US:en', 02:45:03 INFO - 'LOGNAME': 'cltbld', 02:45:03 INFO - 'MAIL': '/var/mail/cltbld', 02:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:03 INFO - 'MOZ_NO_REMOTE': '1', 02:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:03 INFO - 'NO_EM_RESTART': '1', 02:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:03 INFO - 'PWD': '/builds/slave/test', 02:45:03 INFO - 'SHELL': '/bin/bash', 02:45:03 INFO - 'SHLVL': '1', 02:45:03 INFO - 'TERM': 'linux', 02:45:03 INFO - 'TMOUT': '86400', 02:45:03 INFO - 'USER': 'cltbld', 02:45:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:03 INFO - '_': '/tools/buildbot/bin/python'} 02:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:03 INFO - Downloading/unpacking jsonschema==2.5.1 02:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:45:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:45:04 INFO - warning: no files found matching '*.txt' 02:45:04 INFO - no previously-included directories found matching 'build' 02:45:04 INFO - no previously-included directories found matching 'dist' 02:45:04 INFO - no previously-included directories found matching '.git*' 02:45:04 INFO - Installing collected packages: jsonschema, functools32 02:45:04 INFO - Running setup.py install for functools32 02:45:04 INFO - warning: no files found matching '*.txt' 02:45:04 INFO - no previously-included directories found matching 'build' 02:45:04 INFO - no previously-included directories found matching 'dist' 02:45:04 INFO - no previously-included directories found matching '.git*' 02:45:04 INFO - Successfully installed jsonschema functools32 02:45:04 INFO - Cleaning up... 02:45:04 INFO - Return code: 0 02:45:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:45:04 INFO - Using env: {'DISPLAY': ':0', 02:45:04 INFO - 'HOME': '/home/cltbld', 02:45:04 INFO - 'LANG': 'en_US.UTF-8', 02:45:04 INFO - 'LANGUAGE': 'en_US:en', 02:45:04 INFO - 'LOGNAME': 'cltbld', 02:45:04 INFO - 'MAIL': '/var/mail/cltbld', 02:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:04 INFO - 'MOZ_NO_REMOTE': '1', 02:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:04 INFO - 'NO_EM_RESTART': '1', 02:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:04 INFO - 'PWD': '/builds/slave/test', 02:45:04 INFO - 'SHELL': '/bin/bash', 02:45:04 INFO - 'SHLVL': '1', 02:45:04 INFO - 'TERM': 'linux', 02:45:04 INFO - 'TMOUT': '86400', 02:45:04 INFO - 'USER': 'cltbld', 02:45:04 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:04 INFO - '_': '/tools/buildbot/bin/python'} 02:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:45:05 INFO - Cleaning up... 02:45:05 INFO - Return code: 0 02:45:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:05 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')]} 02:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:05 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')]} 02:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:05 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:05 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 02:45:05 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 02:45:05 INFO - Using env: {'DISPLAY': ':0', 02:45:05 INFO - 'HOME': '/home/cltbld', 02:45:05 INFO - 'LANG': 'en_US.UTF-8', 02:45:05 INFO - 'LANGUAGE': 'en_US:en', 02:45:05 INFO - 'LOGNAME': 'cltbld', 02:45:05 INFO - 'MAIL': '/var/mail/cltbld', 02:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:05 INFO - 'MOZ_NO_REMOTE': '1', 02:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:05 INFO - 'NO_EM_RESTART': '1', 02:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:05 INFO - 'PWD': '/builds/slave/test', 02:45:05 INFO - 'SHELL': '/bin/bash', 02:45:05 INFO - 'SHLVL': '1', 02:45:05 INFO - 'TERM': 'linux', 02:45:05 INFO - 'TMOUT': '86400', 02:45:05 INFO - 'USER': 'cltbld', 02:45:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:05 INFO - '_': '/tools/buildbot/bin/python'} 02:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:45:05 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 02:45:05 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 02:45:05 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 02:45:05 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 02:45:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:06 INFO - Downloading docopt-0.6.1.tar.gz 02:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:06 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:06 INFO - Running setup.py install for blobuploader 02:45:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:07 INFO - Running setup.py install for requests 02:45:07 INFO - Running setup.py install for docopt 02:45:07 INFO - Successfully installed blobuploader requests docopt 02:45:07 INFO - Cleaning up... 02:45:07 INFO - Return code: 0 02:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:07 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:07 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 02:45:07 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 02:45:07 INFO - Using env: {'DISPLAY': ':0', 02:45:07 INFO - 'HOME': '/home/cltbld', 02:45:07 INFO - 'LANG': 'en_US.UTF-8', 02:45:07 INFO - 'LANGUAGE': 'en_US:en', 02:45:07 INFO - 'LOGNAME': 'cltbld', 02:45:07 INFO - 'MAIL': '/var/mail/cltbld', 02:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:07 INFO - 'MOZ_NO_REMOTE': '1', 02:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:07 INFO - 'NO_EM_RESTART': '1', 02:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:07 INFO - 'PWD': '/builds/slave/test', 02:45:07 INFO - 'SHELL': '/bin/bash', 02:45:07 INFO - 'SHLVL': '1', 02:45:07 INFO - 'TERM': 'linux', 02:45:07 INFO - 'TMOUT': '86400', 02:45:07 INFO - 'USER': 'cltbld', 02:45:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:07 INFO - '_': '/tools/buildbot/bin/python'} 02:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:07 INFO - Running setup.py (path:/tmp/pip-xnOY4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:07 INFO - Running setup.py (path:/tmp/pip-LjdM14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:07 INFO - Running setup.py (path:/tmp/pip-D6D60g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:07 INFO - Running setup.py (path:/tmp/pip-83FeEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:08 INFO - Running setup.py (path:/tmp/pip-SdVu1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:08 INFO - Running setup.py (path:/tmp/pip-xCHxYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:08 INFO - Running setup.py (path:/tmp/pip-tg6Hqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:08 INFO - Running setup.py (path:/tmp/pip-S_NsaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:08 INFO - Running setup.py (path:/tmp/pip-RuKSbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:08 INFO - Running setup.py (path:/tmp/pip-I78sp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:08 INFO - Running setup.py (path:/tmp/pip-MsVQry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:08 INFO - Running setup.py (path:/tmp/pip-uJgbaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:08 INFO - Running setup.py (path:/tmp/pip-Wb8mhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:08 INFO - Running setup.py (path:/tmp/pip-J8tYGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:08 INFO - Running setup.py (path:/tmp/pip-w2fMOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:08 INFO - Running setup.py (path:/tmp/pip-iCekC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:08 INFO - Running setup.py (path:/tmp/pip-XkiP43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:45:08 INFO - Running setup.py install for manifestparser 02:45:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozcrash 02:45:09 INFO - Running setup.py install for mozdebug 02:45:09 INFO - Running setup.py install for mozdevice 02:45:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozfile 02:45:09 INFO - Running setup.py install for mozhttpd 02:45:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozinfo 02:45:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozInstall 02:45:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for mozleak 02:45:09 INFO - Running setup.py install for mozlog 02:45:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:09 INFO - Running setup.py install for moznetwork 02:45:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Running setup.py install for mozprocess 02:45:10 INFO - Running setup.py install for mozprofile 02:45:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Running setup.py install for mozrunner 02:45:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Running setup.py install for mozscreenshot 02:45:10 INFO - Running setup.py install for moztest 02:45:10 INFO - Running setup.py install for mozversion 02:45:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:10 INFO - Cleaning up... 02:45:10 INFO - Return code: 0 02:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:10 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:10 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 02:45:10 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 02:45:10 INFO - Using env: {'DISPLAY': ':0', 02:45:10 INFO - 'HOME': '/home/cltbld', 02:45:10 INFO - 'LANG': 'en_US.UTF-8', 02:45:10 INFO - 'LANGUAGE': 'en_US:en', 02:45:10 INFO - 'LOGNAME': 'cltbld', 02:45:10 INFO - 'MAIL': '/var/mail/cltbld', 02:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:10 INFO - 'MOZ_NO_REMOTE': '1', 02:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:10 INFO - 'NO_EM_RESTART': '1', 02:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:10 INFO - 'PWD': '/builds/slave/test', 02:45:10 INFO - 'SHELL': '/bin/bash', 02:45:10 INFO - 'SHLVL': '1', 02:45:10 INFO - 'TERM': 'linux', 02:45:10 INFO - 'TMOUT': '86400', 02:45:10 INFO - 'USER': 'cltbld', 02:45:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:10 INFO - '_': '/tools/buildbot/bin/python'} 02:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:10 INFO - Running setup.py (path:/tmp/pip-K0diRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:11 INFO - Running setup.py (path:/tmp/pip-YGNmJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:11 INFO - Running setup.py (path:/tmp/pip-T1nQl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:11 INFO - Running setup.py (path:/tmp/pip-q1Ukv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:11 INFO - Running setup.py (path:/tmp/pip-y4NhhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:11 INFO - Running setup.py (path:/tmp/pip-xIFdZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:11 INFO - Running setup.py (path:/tmp/pip-7Dfu3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:11 INFO - Running setup.py (path:/tmp/pip-J072Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:11 INFO - Running setup.py (path:/tmp/pip-lAys4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:11 INFO - Running setup.py (path:/tmp/pip-ke42MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:11 INFO - Running setup.py (path:/tmp/pip-pWJVIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:11 INFO - Running setup.py (path:/tmp/pip-SbZ4y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:11 INFO - Running setup.py (path:/tmp/pip-ZYGBAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:11 INFO - Running setup.py (path:/tmp/pip-eOHmKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:11 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)) 02:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:11 INFO - Running setup.py (path:/tmp/pip-g4GFeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:12 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)) 02:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:12 INFO - Running setup.py (path:/tmp/pip-_SNaj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:12 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)) 02:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:12 INFO - Running setup.py (path:/tmp/pip-n9yBdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 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)) 02:45:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:12 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 02:45:12 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 02:45:12 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 02:45:12 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 02:45:13 INFO - Downloading blessings-1.6.tar.gz 02:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:13 INFO - Installing collected packages: blessings 02:45:13 INFO - Running setup.py install for blessings 02:45:13 INFO - Successfully installed blessings 02:45:13 INFO - Cleaning up... 02:45:13 INFO - Return code: 0 02:45:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:13 INFO - Reading from file tmpfile_stdout 02:45:13 INFO - Current package versions: 02:45:13 INFO - argparse == 1.2.1 02:45:13 INFO - blessings == 1.6 02:45:13 INFO - blobuploader == 1.2.4 02:45:13 INFO - docopt == 0.6.1 02:45:13 INFO - functools32 == 3.2.3-2 02:45:13 INFO - jsonschema == 2.5.1 02:45:13 INFO - manifestparser == 1.1 02:45:13 INFO - mozInstall == 1.13 02:45:13 INFO - mozcrash == 1.0 02:45:13 INFO - mozdebug == 0.1 02:45:13 INFO - mozdevice == 0.51 02:45:13 INFO - mozfile == 1.2 02:45:13 INFO - mozhttpd == 0.7 02:45:13 INFO - mozinfo == 0.10 02:45:13 INFO - mozleak == 0.1 02:45:13 INFO - mozlog == 3.5 02:45:13 INFO - moznetwork == 0.27 02:45:13 INFO - mozprocess == 0.25 02:45:13 INFO - mozprofile == 0.28 02:45:13 INFO - mozrunner == 6.13 02:45:13 INFO - mozscreenshot == 0.1 02:45:13 INFO - mozsystemmonitor == 0.3 02:45:13 INFO - moztest == 0.8 02:45:13 INFO - mozversion == 1.4 02:45:13 INFO - psutil == 3.1.1 02:45:13 INFO - requests == 1.2.3 02:45:13 INFO - wsgiref == 0.1.2 02:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:13 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:13 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 02:45:13 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 02:45:13 INFO - Using env: {'DISPLAY': ':0', 02:45:13 INFO - 'HOME': '/home/cltbld', 02:45:13 INFO - 'LANG': 'en_US.UTF-8', 02:45:13 INFO - 'LANGUAGE': 'en_US:en', 02:45:13 INFO - 'LOGNAME': 'cltbld', 02:45:13 INFO - 'MAIL': '/var/mail/cltbld', 02:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:13 INFO - 'MOZ_NO_REMOTE': '1', 02:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:13 INFO - 'NO_EM_RESTART': '1', 02:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:13 INFO - 'PWD': '/builds/slave/test', 02:45:13 INFO - 'SHELL': '/bin/bash', 02:45:13 INFO - 'SHLVL': '1', 02:45:13 INFO - 'TERM': 'linux', 02:45:13 INFO - 'TMOUT': '86400', 02:45:13 INFO - 'USER': 'cltbld', 02:45:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:13 INFO - '_': '/tools/buildbot/bin/python'} 02:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 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)) 02:45:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:45:13 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 02:45:13 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 02:45:13 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 02:45:13 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 02:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:45:15 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)) 02:45:15 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)) 02:45:15 INFO - Installing collected packages: simplejson 02:45:15 INFO - Running setup.py install for simplejson 02:45:15 INFO - building 'simplejson._speedups' extension 02:45:15 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 02:45:16 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 02:45:16 INFO - Successfully installed simplejson 02:45:16 INFO - Cleaning up... 02:45:16 INFO - Return code: 0 02:45:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45: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')]} 02:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:16 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 0x1dba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2126a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, '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': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', '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 02:45:16 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 02:45:16 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 02:45:16 INFO - Using env: {'DISPLAY': ':0', 02:45:16 INFO - 'HOME': '/home/cltbld', 02:45:16 INFO - 'LANG': 'en_US.UTF-8', 02:45:16 INFO - 'LANGUAGE': 'en_US:en', 02:45:16 INFO - 'LOGNAME': 'cltbld', 02:45:16 INFO - 'MAIL': '/var/mail/cltbld', 02:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:16 INFO - 'MOZ_NO_REMOTE': '1', 02:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:16 INFO - 'NO_EM_RESTART': '1', 02:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:16 INFO - 'PWD': '/builds/slave/test', 02:45:16 INFO - 'SHELL': '/bin/bash', 02:45:16 INFO - 'SHLVL': '1', 02:45:16 INFO - 'TERM': 'linux', 02:45:16 INFO - 'TMOUT': '86400', 02:45:16 INFO - 'USER': 'cltbld', 02:45:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:16 INFO - '_': '/tools/buildbot/bin/python'} 02:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:45:16 INFO - Cleaning up... 02:45:16 INFO - Return code: 0 02:45:16 INFO - Running post-action listener: _resource_record_post_action 02:45:16 INFO - Running post-action listener: _start_resource_monitoring 02:45:16 INFO - Starting resource monitoring. 02:45:16 INFO - [mozharness: 2017-09-03 09:45:16.420907Z] Finished create-virtualenv step (success) 02:45:16 INFO - [mozharness: 2017-09-03 09:45:16.421435Z] Running install step. 02:45:16 INFO - Running pre-action listener: _resource_record_pre_action 02:45:16 INFO - Running main action method: install 02:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:16 INFO - Reading from file tmpfile_stdout 02:45:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:16 INFO - Reading from file tmpfile_stdout 02:45:16 INFO - Output received: 02:45:16 INFO - Usage: mozinstall [options] installer 02:45:16 INFO - Options: 02:45:16 INFO - -h, --help show this help message and exit 02:45:16 INFO - -d DEST, --destination=DEST 02:45:16 INFO - Directory to install application into. [default: 02:45:16 INFO - "/builds/slave/test"] 02:45:16 INFO - --app=APP Application being installed. [default: firefox] 02:45:16 INFO - mkdir: /builds/slave/test/build/application 02:45:16 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'] 02:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:45:33 INFO - Reading from file tmpfile_stdout 02:45:33 INFO - Output received: 02:45:33 INFO - /builds/slave/test/build/application/firefox/firefox 02:45:33 INFO - Running post-action listener: _resource_record_post_action 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.279459Z] Finished install step (success) 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.279605Z] Running setup-mitmproxy step. 02:45:33 INFO - Running pre-action listener: _resource_record_pre_action 02:45:33 INFO - Running main action method: setup_mitmproxy 02:45:33 INFO - Skipping: mitmproxy is not required 02:45:33 INFO - Running post-action listener: _resource_record_post_action 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.280133Z] Finished setup-mitmproxy step (success) 02:45:33 INFO - [mozharness: 2017-09-03 09:45:33.280235Z] Running run-tests step. 02:45:33 INFO - Running pre-action listener: _resource_record_pre_action 02:45:33 INFO - Running pre-action listener: _set_gcov_prefix 02:45:33 INFO - Running main action method: run_tests 02:45:33 WARNING - Try message not found. 02:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:33 INFO - Python 2.7.3 02:45:33 INFO - Return code: 0 02:45:33 INFO - grabbing minidump binary from tooltool 02:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:33 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 0x212a090>, '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 0x212ad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2124f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:33 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 02:45:33 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 02:45:33 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 02:45:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:33 INFO - Return code: 0 02:45:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:45:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:33 INFO - ENV: RUST_BACKTRACE is now full 02:45:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:45:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:33 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/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 02:45:33 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/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 02:45:33 INFO - Using env: {'DISPLAY': ':0', 02:45:33 INFO - 'HOME': '/home/cltbld', 02:45:33 INFO - 'LANG': 'en_US.UTF-8', 02:45:33 INFO - 'LANGUAGE': 'en_US:en', 02:45:33 INFO - 'LOGNAME': 'cltbld', 02:45:33 INFO - 'MAIL': '/var/mail/cltbld', 02:45:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:33 INFO - 'MOZ_NO_REMOTE': '1', 02:45:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:33 INFO - 'NO_EM_RESTART': '1', 02:45:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:33 INFO - 'PWD': '/builds/slave/test', 02:45:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:33 INFO - 'RUST_BACKTRACE': 'full', 02:45:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:45:33 INFO - 'SHELL': '/bin/bash', 02:45:33 INFO - 'SHLVL': '1', 02:45:33 INFO - 'STYLO_FORCE_ENABLED': '1', 02:45:33 INFO - 'TERM': 'linux', 02:45:33 INFO - 'TMOUT': '86400', 02:45:33 INFO - 'USER': 'cltbld', 02:45:33 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:33 INFO - '_': '/tools/buildbot/bin/python'} 02:45:33 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/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 02:45:33 INFO - mozversion application_buildid: 20170903085438 02:45:33 INFO - mozversion application_changeset: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb 02:45:33 INFO - mozversion application_display_name: Nightly 02:45:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:33 INFO - mozversion application_name: Firefox 02:45:33 INFO - mozversion application_remotingname: firefox 02:45:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:45:33 INFO - mozversion application_vendor: Mozilla 02:45:33 INFO - mozversion application_version: 57.0a1 02:45:33 INFO - mozversion platform_buildid: 20170903085438 02:45:33 INFO - mozversion platform_changeset: 37824bf5c5b08afa7e689fceb935b8f457ebd9eb 02:45:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:45:33 INFO - mozversion platform_version: 57.0a1 02:45:33 INFO - using testdate: 1504431933 02:45:33 INFO - actual date: 1504431933 02:45:33 INFO - starting webserver on 'localhost:35621' 02:45:33 INFO - SUITE-START | Running 2 tests 02:45:33 INFO - TEST-START | dromaeo_css 02:45:33 INFO - Initialising browser for dromaeo_css test... 02:45:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35621/getInfo.html -profile /tmp/tmpgK4zeY/profile 02:45:33 INFO - TEST-INFO | started process 2124 (/builds/slave/test/build/application/firefox/firefox http://localhost:35621/getInfo.html) 02:45:39 INFO - TEST-INFO | 2124: exit 0 02:45:39 INFO - Browser initialized. 02:45:39 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:39 INFO - Using env: {'DISPLAY': ':0', 02:45:39 INFO - 'HOME': '/home/cltbld', 02:45:39 INFO - 'JSGC_DISABLE_POISONING': '1', 02:45:39 INFO - 'LANG': 'en_US.UTF-8', 02:45:39 INFO - 'LANGUAGE': 'en_US:en', 02:45:39 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:45:39 INFO - 'LOGNAME': 'cltbld', 02:45:39 INFO - 'MAIL': '/var/mail/cltbld', 02:45:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:45:39 INFO - 'MOZ_CRASHREPORTER': '1', 02:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:39 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:45:39 INFO - 'MOZ_NO_REMOTE': '1', 02:45:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:39 INFO - 'NO_EM_RESTART': '1', 02:45:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:39 INFO - 'PWD': '/builds/slave/test', 02:45:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:39 INFO - 'RUST_BACKTRACE': 'full', 02:45:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:45:39 INFO - 'SHELL': '/bin/bash', 02:45:39 INFO - 'SHLVL': '1', 02:45:39 INFO - 'STYLO_FORCE_ENABLED': '1', 02:45:39 INFO - 'TERM': 'linux', 02:45:39 INFO - 'TMOUT': '86400', 02:45:39 INFO - 'USER': 'cltbld', 02:45:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 02:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:39 INFO - '_': '/tools/buildbot/bin/python'} 02:45:39 INFO - TEST-INFO | started process 2321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgK4zeY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:40 INFO - PID 2321 | 02:45:40 INFO - PID 2321 | (/builds/slave/test/build/application/firefox/firefox:2373): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:45:40 INFO - PID 2321 | 02:45:50 INFO - PID 2321 | RSS: Main: 172498944 02:45:50 INFO - PID 2321 | 02:48:49 INFO - PID 2321 | Cycle 1(1): loaded http://localhost:35621/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35621/tests/dromaeo/cssquery-ext.html) 02:48:50 INFO - PID 2321 | RSS: Main: 174174208 02:48:50 INFO - PID 2321 | 02:51:52 INFO - PID 2321 | Cycle 1(1): loaded http://localhost:35621/tests/dromaeo/cssquery-ext.html (next: http://localhost:35621/tests/dromaeo/cssquery-jquery.html) 02:51:53 INFO - PID 2321 | RSS: Main: 170758144 02:51:53 INFO - PID 2321 | 02:54:54 INFO - PID 2321 | Cycle 1(1): loaded http://localhost:35621/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35621/tests/dromaeo/cssquery-mootools.html) 02:54:55 INFO - PID 2321 | RSS: Main: 173027328 02:54:55 INFO - PID 2321 | 02:57:57 INFO - PID 2321 | Cycle 1(1): loaded http://localhost:35621/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35621/tests/dromaeo/cssquery-prototype.html) 02:57:58 INFO - PID 2321 | RSS: Main: 171450368 02:57:58 INFO - PID 2321 | 03:01:01 INFO - PID 2321 | Cycle 1(1): loaded http://localhost:35621/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35621/tests/dromaeo/cssquery-yui.html) 03:01:02 INFO - PID 2321 | RSS: Main: 172552192 03:01:02 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | Cycle 1(1): loaded http://localhost:35621/tests/dromaeo/cssquery-yui.html (next: http://localhost:35621/tests/dromaeo/cssquery-dojo.html) 03:04:03 INFO - PID 2321 | RSS: Main: 175263744 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | __start_tp_report 03:04:03 INFO - PID 2321 | _x_x_mozilla_page_load 03:04:03 INFO - PID 2321 | _x_x_mozilla_page_load_details 03:04:03 INFO - PID 2321 | |i|pagename|runs| 03:04:03 INFO - PID 2321 | |0;dojo.html;3326.5010248462713;3366.5623468949034;3373.954074236987;3377.3583019226353;3397.0488263286275;6428.32502587228;6452.7096280667365;6473.902891456626;6494.0583615375745;6536.986767051103;6506.73973041079;6526.053722210277;6535.281119076898;6537.411632953033;6626.337366263371;6040.335563088057;6069.78755743549;6083.604565703237;6112.266528016644;6118.082287656843;5968.4031596840405;6059.030555111183;6111.847203819895;6138.232720909887;6155.538334624899;5861.618994765348;5962.314333851619;5964.284285885678;6017.157597936249;6020.759169633209;6033.577649564532;6071.969640151771;6090.939090609081;6100.023996160593;6105.8168254952425;5975.40245975399;5985.461308482214;6010.909836352458;6092;6098.390160983866;6340.017297318876;6451.870962580769;6544.116544266558;6586.73653053882;6638.5684930479365;6975.337342952462;7023.122109736283;7024.613646249454;7032;7032.296770322978;7124.679389427488;7163.0688010558815;7212.423006159494;7217.422606191492;7218.639068046629;6532.575382600164;6552.312007239267;6552.3447655234095;6634.834129146761;6636.634985075867;7031.296870312928;7161.606111663804;7171.713131474787;7235.710571577078;7302.744403945836;6943.618101004392;6948.478864085214;6954.582725036514;6997.860042799217;7002.01971723959;7016.193137789118;7035.753748618774;7120.821979450555;7122.28777122294;7136;7002.579845209304;7004.579725216503;7022.894656580155;7096.503244772816;7100.076989991371;6912.481563882729;7004;7027.824304392431;7029.3673569379;7073.328033836778;5490.890182196414;5532.280803495601;5543.7782488700805;5559.471850174227;5571.387147413781;4847.079054979543;4847.442544107403;4857.0043141155975;4912.263160525878;4932.55606995365;5980.491658209101;6111.8472038198515;6114.694265286718;6188.793185328907;6196.783112591038;6997.7200911962955;7053.858922821515;7116.359527642537;7120.181179164462;7123.5369700970305;6121.602095863755;6146.569740118238;6154.78458253959;6165.907511387333;6180.3201647818705;6008.128821320884;6020.909686354708;6068.848278793065;6080.513558915276;6091.817245482643;6777.898331525031;6789.1174147360525;6888.138982627172;6901.275366086488;6922.7923162305215;6847.726090956506;7005.6146911918295;7014.929850701427;7102.325279098477;7109.075820143556;6693.598384096969;6756.966215168893;6810.455163587;6830.658467076527;6838.247792742894;6863.10779598669;6889.724411023703;6912.343327383891;6961.965190174017;6985.650717464005;7104.857902842017;7106.5736055836815;7153.535020223669;7170.960210769514;7197.496175267681;6663.46692264608;6777.423918966943;6783.084283621648;6810.28492008332;6872.725090996304;6679.532432729662;6693;6717.193936727624;6748.93251067483;6854.246032936473;6714.328567143247;6760.1549806274215;6760.18877734675;6762.323767623198;6790.015447760146;6827.829304267234;6884.759033433806;6908.274631163656;6923.9653801730665;6938.06336144614;6470.255920569007;6537.5096867736065;6598.571092878948;6608.041833934149;6677.131972843499 03:04:03 INFO - PID 2321 | |1;ext.html;804.778685861388;846.2510678049925;864.0883867519766;884.363258453913;1131.9094472442205;30773.23066923328;31418.842905785466;40584.39123413151;40829.795851020775;41014.58985410145;40994.59005409953;41493.37759933603;41512;41534.37698434518;41548.79225603875;7268.527545709539;7664;7897.526148431112;7898;7917.445778795487;7627.580483073429;7729.845403091935;7747.2640099190485;7751.689932402697;7761.340286075662;7747.9612601936915;7786.26030527099;7812.179721129285;7840.13758486566;7871.8032049198655;7807.063152421717;7809.258120478546;7825.804354891116;7845.921540784576;7847.489913155655;7730.613469326511;7789.10425301092;7790.182030886732;7790.649420776079;7798.103218129931;36812.89561313165;37295.25409491795;37323.25353492915;37367.813160934296;37458.43812342817;3564.2515071834946;3626.8005259710703;3626.9818650906577;3630.3283892479712;3633.4913112164318;31394.843025784954;31483.055508334786;31483.685163148304;31490.685093149004;31538.842305788323;5030.798768049273;5157.071727089123;5173.430922598511;5186.922196167023;5199.948000519984;184155;184644;185001;185751;186111.06944465326;47609;47647.52352476431;47756.5224347759;47779;47873.76063119662;49434.25848612274;49584;49637.75181124071;49713.25430118479;49895.50104498981;14472.493462728755;15925;16196.838031619769;16288;16288.185590720417;12109.091818113677;13228.272445015424;13340.799888001688;13355.532556360675;13361.398737056856;13536.796948045787;13647.249401282827;13683.179009259477;13773.242471664154;13831.100978436369;5435.972820135874;5508.256385388001;5515.821250605988;5524.613277070647;5555.666660000413;984.1782111936614;990.895955924632;994.4480813148772;1012.2408193854609;1029.8300780371305;21676.24133155332;22048;22100.447488812908;22113.336599901708;22460.10159593598;1074.2641290715885;1076.8976947190004;1093.7265683579105;1093.94530273486;1101.30067407197;11697.590584329508;11758.176927615155;11822.172447928735;11863.76272474563;11982.700432489084;226975;227898;228393;228536;229945;48947.755261223465;49034.264486032735;49067.754661227176;49418;49525;1410.8941829362839;1425.771876499755;1447.3848614339074;1452.7820826876052;1458.5478501664518;21035.789642103384;21348.57302853903;21669.783302166776;21736.891315543322;21855.78144218601;35680;35950.820245898605;35999.82000090087;36073.45889811603;36103.27793444064;202321;203836;203866;204638;204920;32408.675913240564;32674.183145421553;34800.65199347974;36622;36735.448968266035;45434.31848522341;46539;46631.766841165576;46649.53350466588;47438.288425674335;32982;33002.66997329996;33122.83438582792;33206.16984575405;33701.15747106342;33490;33734.83132584322;33828.15429614279;34058.318833623685;34461.827690861384;36970;37865.432018520296;37959.81020094882;38124;38262.42606360962;31871;32777.50833737448;32984.505232421056;33023.66976330206;33801.83099084489;23707;24129.155479558132;24167.274981749873;24280.878595606908;24362.756372436048 03:04:03 INFO - PID 2321 | |2;jquery.html;564.6640249051812;576.1242910775621;578.9739461724222;595.2291782142125;602.9638221706697;22424.88787556062;22784.43038924028;23169.420764480856;23240.41898952527;23282.88358558207;25521.489570208632;25766.74233257667;25848;25879.61180582293;26318;6757.358050985161;6876.277990810968;6898.896516552256;6901.171859376882;6910.412614927737;6039.275286965571;6623.966880165616;6640.833979150536;6649.634270115142;6805.761798337059;6511.57674751142;6514.315996820336;6539.705713242892;6542.182227221598;6598.538102332838;6513.348665133472;6524.412802847743;6525.869482610368;6553.967230163867;6590.538662293641;6118.4799292060225;6123.418275263887;6133.754649814002;6141.048137538644;6152.107944348089;28212;28809.423811523862;29253;29354.41291174186;29549.261268468246;2042.101475350841;2072.367927782026;2073.39871437283;2074.159965214091;2075.2217918280644;19196.520086997796;19835.10742016613;19839.504012399662;19846.801531984784;19914.40256792284;2374.0820395745754;2395.6765836612008;2404.230646193219;2406.9398265043337;2440.9755902440925;134982;137714;140337;140420;140986.29506852504;14481.710365792625;14737.336819842918;14756.934029235916;14819.851801481847;15696.293666784793;23181.536369272857;23286.417839554146;23306.417339566648;23344.533109337717;23353.766462335498;10247.487625618689;10404.167666586654;10584.153267738562;10615.416152111553;10854.728631784268;7704.383649308042;9884.901150988542;9901.108900199017;9962.452065136487;10050.346727462691;7971.242731940572;9137.451752894847;9184.173424391836;9209.815803683889;9414.482203478738;2604.5442047641586;2684.5302072137297;2704.2428120126397;2708.349996000946;2810.873510692024;952.8808898887639;969.8351280282369;978.7406337320616;978.8238117138983;980.8970058143935;19401.902990484956;19673.01634918277;19947.301844435377;20203.79796202019;24845.62731559028;1025.8204814157493;1060.989390106089;1077.498962982217;1080.8702955645374;1084.2572837606265;10787.352758834495;11154.944225278821;11313.981741643292;11575.016123629586;11726.179167458196;488411;491113;495614;497276;512225;129353;130244;131392;138399;138797;1228.3858070964518;1230.3540641163281;1260.9495620175273;1263.6777621706406;1268.4862630634607;21134.68297975501;21311.467213319793;21452.712837229818;21637.242696505546;21946.670799938332;61574.38425615687;61709;62397;63421.36578634154;63525;79283.20716792758;79749;79853.40659670213;79971.60014199892;80036;20253;20684.689729653765;20790;20796.896015519826;20835.166593336096;23339;23689.881550592138;23782.405439864142;23797.524049518568;23835.523289533765;18217.726734098735;18289;18511.444656660322;18685.346012889484;18685.90657046706;16695.91652041732;16858.539505187648;16968.32126714967;17039.744403833705;17211.569710757332;19068.713969290195;19070.80929190746;19121.904390477957;19336.22655093837;19351.806481935;20237.79762202418;20297;20370.57405981567;20421.489462762955;20670.896645516677;18430;18480.075996200405;18521.07394630236;18636;18636.534086647942 03:04:03 INFO - PID 2321 | |3;mootools.html;1281.5130250504808;1326.5091915991081;1341.2489006156552;1346.7575836349454;1352.9526466573666;14704.41182352706;15417.306221220044;15426.69146617067;15432.305546250418;15569.221538923066;15553.766693499578;15890;15907.920460397681;15922.363105475768;15930.442434514795;2750.22993561803;2807.410443806803;2814.408974115438;2815.831050136988;2817.7464028237455;2720.319920019995;2810.297425643589;2814.6763122240895;2814.887404503828;2815.3524689321466;2729.863506824651;2739.4521095780924;2745.3960128771637;2747.972520274792;2765.3363192833776;2632.5656266716064;2645.5899335603012;2655.0972669292437;2669.0391459074717;2672.7327267273313;2589.741025897414;2594.286571192918;2601.1546247469646;2604.2187343796973;2609.7259787722205;14868.330925108396;15161.696766064617;15165.317560709684;15168.772468412983;15175.696486070217;7799.649015794246;8046.758597242092;8062.556559389232;8068.072171700271;8082.919170808275;5198.298229738974;5306.310179676656;5312.654677445954;5395.433479484676;5465.125579907235;1953.2870502266712;1969.3008981811538;1999.5201151723627;2013.6878783788536;2021.5754691514799;25472.872635636704;25647.358816029562;25669.871650641813;25732;25747.613785793415;7058.964705176441;7071.003124673963;7376.225496322916;7379.262073792578;7394.630268486554;17115.400960966308;17201.311947521957;17203.397881074103;17263.654726905643;17310.480685579452;7687.807804804813;7916.050073991158;7916.089649690244;7919.802004949807;7922.049354077432;7198.820029499199;7285.344319011315;7295.343419092307;7313.963430182815;7324.63376831167;5062;5134.589232861362;5160.251763494272;5175.301334319819;5204.583633309327;1445.4651778841896;1449.282605110477;1450.6155868694805;1456.992715036418;1463.231803303253;881.828043531518;902.6028547439106;906.1165363770403;917.0691747875911;928.4661319741176;7564.848703025908;7681.42389320792;7728.381729461629;7778.533288002738;7830.451868369273;722.1695050691746;723.8371366442614;726.1576571177409;986.2455221755363;1017.0592202212923;5210.140326846028;5385.057614917374;5541.695206763586;5595.160725891067;5715.428457154251;21688.24091156802;22443.775562244497;22579.548409031726;22580.887095564416;22612.773872261067;20766.377008689764;21706.131754729635;21978.340649780534;22033.669494957587;22059.11763529441;11359.375234362024;11680.299182049104;11694.415279236004;11743.295402275891;11752.177347585757;8439.620217090369;8542.26924633208;8641.308695304235;8881.289496840367;8985.326100542616;18174.72737908959;18445.631087378446;18485.630287394444;18719.438416847515;18831;19048.714269285694;19318.517037074187;19360.70958935645;19438;19498.707519386935;12135.453904574491;12173.087018473472;12416.937915310365;12429.378531073591;12453.128281020241;13879.583612491642;13891.791623125864;13923.791143133063;13948;14000;10768.192385570957;10854.023137917626;10955.726106847074;11004.834927476255;11269.098472122047;10834.295770774874;10993.670189894316;11012.559497620005;11082.16883733707;11279.266847654877;9835.852462213215;9881.950590247003;9998.25013124004;10001.249906257206;10002.899971000197;6725.260221375547;6765.492588055817;6821.727130914708;6835.453163746988;6881;6899.275576064441;6992;6994.720211191496;7020.508564400443;7145.1783044948415 03:04:03 INFO - PID 2321 | |4;prototype.html;509.454883274896;519.4545726986664;525.3669328459207;531.4950796743095;531.9202119682047;6312.9684351578235;6490.480761539072;6514.478841692665;6538.705758240879;6546.607203567777;6266.310705822356;6395.488360931126;6422.775202867901;6435.227772667275;6444.645544495051;5249.845034092503;5253.4221235664045;5286.867828304285;5295.20571914214;5320.467953204688;5251.264822924793;5274.604404669646;5284.904199245596;5307.336582927134;5311.840644780663;4918.336024636664;5009.874753131165;5075.817398518636;5076.796928122871;5079.3142925705115;5020.899582008357;5052.8484145475695;5073.315102461157;5078.898422031539;5110.8466745997675;4374.365716971053;4468.82124715011;4548.135854187693;4560.794764235618;4567.862964111082;6063.514918806485;6102.7864024759365;6117.632942023492;6173.351798061184;6175.382461753834;5787.971060144672;5804.9419505805245;5857.824265272048;5859.238299021143;5860.912086318709;6532.5753826001155;6633.30350313215;6705.1283333166375;6715.899261511081;6739.59562426256;4974.726390048546;4979.751012449363;4987.825426110105;4992.775325110379;5017.48775856898;6579.309172536862;6800.863982720318;6856.554323968926;6991.265917078685;7038.401735852459;5049.924251136236;5058.772355244023;5062.341895553628;5069.670471419419;5102.591792656579;5117.722613436985;5149.48505149482;5172.6551096714375;5210.374755029421;5215.58275337972;5748.7125643717645;5794.82615521535;5800.767969281266;5841.766329346863;5852.4147585241135;6728.966355168192;6746.224184218878;6757.966210168917;6809.638072385543;6843.589384636838;1778.288684526174;1789.702465712374;1794.6450429925324;1799.4781513360979;1801.5766294920684;1186.323795436593;1213.4296880466168;1224.9571265005682;1236.6722818453118;1237.9690507737198;5887.499562537232;5890.469857712741;5919.467247947706;5981.700914954235;6009.737955029405;6869.484788640872;6909.827254318581;6910.965445172742;6986.895196572055;7047.471439642048;5901.937651222821;5966.373530779292;5983.820485385445;5998.730057147439;6010.789622363283;3659.469376940329;3659.4876717259604;3675.2649470106085;3676.889693309205;3725.795081270502;6635.402813746786;6671.5997040177745;6674.532782705164;6711.127553418024;6733.360330768569;6619.735210591522;6927.307269273133;6949.992251123559;6979.953007048984;7144.678489467987;6613.222446572548;6661.800145995628;6682.331766823376;6706.698198580978;6714;6789.72841086351;6887.20797108339;6931.376176144171;6962.443004559522;6975.162980442379;6720;6747.190337159573;6784.151981002375;6822.249552549315;6867.519273650796;6608;6625.958165519126;6662.533622646368;6664.400203981665;6675.899861501985;5046.6719663221775;5075.908679633896;5109.565686916654;5114.1305977984575;5114.769835357343;6491.350864913471;6704.7318107277115;6766.289539598468;6837.1111755471475;6934.410575100971;6445.452136568444;6606.471482281502;6659.800205993828;6689.732410703517;6714.865702685821;6593.208814942238;6596.769113081211;6608.966955165193;6708.228553716385;6731.629760363031;6577.572457790228;6615.900761488678;6665.733370665119;6674.16572928384;6746.966265168643;6612.239592446737;6691;6722.899156512754;6790.796276111724;6793.320667933365;6462.870742585216;6540.574862633914;6589.374009469093;6602.306757790555;6612.107365505595 03:04:03 INFO - PID 2321 | |5;yui.html;868.7741187291306;898.1377877237851;899.2221728205101;899.4108858697556;917.4266083697692;17456.825431745678;18684.81315186848;19666.508337291576;19677.212911483522;19760.505987350287;20527.178912843505;20877.060532276046;21305.893470532625;21431;21461.892690536566;953.1278879824952;960.4237457525498;960.8558716192592;964.7057647417535;965.242284806427;960.1071003966308;981.0728861226144;982.9508524573779;989.4953573677441;991.2268430624089;1053.441675911768;1054.3305001324138;1056.1761825775907;1056.4031322302912;1058.4284486377346;1050.6480329089763;1051.0225490294024;1051.0855555666542;1051.5057922776282;1053.7418332508507;770.938324934004;771.0708596141692;771.7993321736388;772.2277722277722;772.5596410046276;19693.11380987859;19780.50548736279;19948.900255498775;19969.201231950705;20846.68729969052;21292.680609790867;21647.45881352963;21655.783442165535;21728.456788580253;21812.781872181233;16970.40603578869;17022.48932532026;17222.397216097375;17224.741628875578;17339.566510837205;3740.682042026431;3745.887623371276;3759.248150369937;3769.754965927206;3770.453284273765;121994;127179.72820271771;130017.34991325077;130159;132190.99999999904;16763.91618041902;17423.21595528204;17455.73816392755;17481;17581.120943953007;30388.54417183744;30485.84757076245;30956.84521577423;30970;31257.8437107813;7606.315431611181;7818.296353328114;8706.869396959051;9071.455712657262;9370.437773733598;4267.16790225903;4365.541618130114;4365.956340436618;4375.934360984587;4384.6273066789045;5306.52241298285;5361.919571206435;5379.67721936685;5391.110466772939;5453.318335208099;1024.4314405504867;1031.7162780235494;1053.2258789789498;1056.8573242612304;1060.2737125069352;647.2976820150095;651.6643928376795;659.7954634063456;665.70043480434;672.1765836849918;11384.658460246206;11531.192816502764;12106;13201.47194112244;13583.932080339733;654.502578040683;657.7500549791145;667.5994403357946;671.684308375063;683.9452843772486;5167.483251674803;5422.186671999231;5589.916151257735;5642.322921249476;5816.738246778905;112728.43635781769;113264.43367783273;114525;114953.4252328733;117824;97249.51375243078;98416.50791745995;99711.00577988545;101607;101777;86023.56988215019;86792;87031;87560.56219718988;89530.55234723784;10821.350718956573;10836.295640783324;11124.721881952692;11153.665390038312;12565.87434125647;40308.178427509796;40327.39508907427;40374.39438408367;41044;41816.790916045225;67694;70100.29899700938;71149.64425178048;71791;75393;17696.911515442855;18123;18166.636667266845;18188.81811181924;18229.908850455664;19887.502812429804;20156.697649534974;20542.38372848817;20636.380908572766;20660.276890308767;17948.820511794715;18056.638867222846;18091.638167236844;18204.45386638403;18307;17305.30778768835;17701.114944252993;17799.644007119525;17842;17973.37093201732;16051.19744012818;16098.356065757238;16209.270582823565;16393;16725.916370418556;13278.402471888981;13758.65603359924;13975.440982360591;14123.64690882736;14124.929375353058;14108;14297.499587514387;14340.784888226894;14347.139171649735;14373.353199105855 03:04:03 INFO - PID 2321 | __end_tp_report 03:04:03 INFO - PID 2321 | __start_cc_report 03:04:03 INFO - PID 2321 | _x_x_mozilla_cycle_collect,378 03:04:03 INFO - PID 2321 | __end_cc_report 03:04:03 INFO - PID 2321 | __startTimestamp1504433043966__endTimestamp 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | ------- Summary: start ------- 03:04:03 INFO - PID 2321 | Number of tests: 6 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | [#0] dojo.html Cycles:165 Average:6470.84 Median:6693.00 stddev:761.50 (11.4%) stddev-sans-first:722.78 03:04:03 INFO - PID 2321 | Values: 3326.5 3366.6 3374.0 3377.4 3397.0 6428.3 6452.7 6473.9 6494.1 6537.0 6506.7 6526.1 6535.3 6537.4 6626.3 6040.3 6069.8 6083.6 6112.3 6118.1 5968.4 6059.0 6111.8 6138.2 6155.5 5861.6 5962.3 5964.3 6017.2 6020.8 6033.6 6072.0 6090.9 6100.0 6105.8 5975.4 5985.5 6010.9 6092.0 6098.4 6340.0 6451.9 6544.1 6586.7 6638.6 6975.3 7023.1 7024.6 7032.0 7032.3 7124.7 7163.1 7212.4 7217.4 7218.6 6532.6 6552.3 6552.3 6634.8 6636.6 7031.3 7161.6 7171.7 7235.7 7302.7 6943.6 6948.5 6954.6 6997.9 7002.0 7016.2 7035.8 7120.8 7122.3 7136.0 7002.6 7004.6 7022.9 7096.5 7100.1 6912.5 7004.0 7027.8 7029.4 7073.3 5490.9 5532.3 5543.8 5559.5 5571.4 4847.1 4847.4 4857.0 4912.3 4932.6 5980.5 6111.8 6114.7 6188.8 6196.8 6997.7 7053.9 7116.4 7120.2 7123.5 6121.6 6146.6 6154.8 6165.9 6180.3 6008.1 6020.9 6068.8 6080.5 6091.8 6777.9 6789.1 6888.1 6901.3 6922.8 6847.7 7005.6 7014.9 7102.3 7109.1 6693.6 6757.0 6810.5 6830.7 6838.2 6863.1 6889.7 6912.3 6962.0 6985.7 7104.9 7106.6 7153.5 7171.0 7197.5 6663.5 6777.4 6783.1 6810.3 6872.7 6679.5 6693.0 6717.2 6748.9 6854.2 6714.3 6760.2 6760.2 6762.3 6790.0 6827.8 6884.8 6908.3 6924.0 6938.1 6470.3 6537.5 6598.6 6608.0 6677.1 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | [#1] ext.html Cycles:180 Average:37383.30 Median:35975.32 stddev:53489.05 (148.7%) stddev-sans-first:53568.59 03:04:03 INFO - PID 2321 | Values: 804.8 846.3 864.1 884.4 1131.9 30773.2 31418.8 40584.4 40829.8 41014.6 40994.6 41493.4 41512.0 41534.4 41548.8 7268.5 7664.0 7897.5 7898.0 7917.4 7627.6 7729.8 7747.3 7751.7 7761.3 7748.0 7786.3 7812.2 7840.1 7871.8 7807.1 7809.3 7825.8 7845.9 7847.5 7730.6 7789.1 7790.2 7790.6 7798.1 36812.9 37295.3 37323.3 37367.8 37458.4 3564.3 3626.8 3627.0 3630.3 3633.5 31394.8 31483.1 31483.7 31490.7 31538.8 5030.8 5157.1 5173.4 5186.9 5199.9 184155.0 184644.0 185001.0 185751.0 186111.1 47609.0 47647.5 47756.5 47779.0 47873.8 49434.3 49584.0 49637.8 49713.3 49895.5 14472.5 15925.0 16196.8 16288.0 16288.2 12109.1 13228.3 13340.8 13355.5 13361.4 13536.8 13647.2 13683.2 13773.2 13831.1 5436.0 5508.3 5515.8 5524.6 5555.7 984.2 990.9 994.4 1012.2 1029.8 21676.2 22048.0 22100.4 22113.3 22460.1 1074.3 1076.9 1093.7 1093.9 1101.3 11697.6 11758.2 11822.2 11863.8 11982.7 226975.0 227898.0 228393.0 228536.0 229945.0 48947.8 49034.3 49067.8 49418.0 49525.0 1410.9 1425.8 1447.4 1452.8 1458.5 21035.8 21348.6 21669.8 21736.9 21855.8 35680.0 35950.8 35999.8 36073.5 36103.3 202321.0 203836.0 203866.0 204638.0 204920.0 32408.7 32674.2 34800.7 36622.0 36735.4 45434.3 46539.0 46631.8 46649.5 47438.3 32982.0 33002.7 33122.8 33206.2 33701.2 33490.0 33734.8 33828.2 34058.3 34461.8 36970.0 37865.4 37959.8 38124.0 38262.4 31871.0 32777.5 32984.5 33023.7 33801.8 23707.0 24129.2 24167.3 24280.9 24362.8 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | [#2] jquery.html Cycles:180 Average:36439.28 Median:23284.65 stddev:84254.12 (361.8%) stddev-sans-first:84447.42 03:04:03 INFO - PID 2321 | Values: 564.7 576.1 579.0 595.2 603.0 22424.9 22784.4 23169.4 23240.4 23282.9 25521.5 25766.7 25848.0 25879.6 26318.0 6757.4 6876.3 6898.9 6901.2 6910.4 6039.3 6624.0 6640.8 6649.6 6805.8 6511.6 6514.3 6539.7 6542.2 6598.5 6513.3 6524.4 6525.9 6554.0 6590.5 6118.5 6123.4 6133.8 6141.0 6152.1 28212.0 28809.4 29253.0 29354.4 29549.3 2042.1 2072.4 2073.4 2074.2 2075.2 19196.5 19835.1 19839.5 19846.8 19914.4 2374.1 2395.7 2404.2 2406.9 2441.0 134982.0 137714.0 140337.0 140420.0 140986.3 14481.7 14737.3 14756.9 14819.9 15696.3 23181.5 23286.4 23306.4 23344.5 23353.8 10247.5 10404.2 10584.2 10615.4 10854.7 7704.4 9884.9 9901.1 9962.5 10050.3 7971.2 9137.5 9184.2 9209.8 9414.5 2604.5 2684.5 2704.2 2708.3 2810.9 952.9 969.8 978.7 978.8 980.9 19401.9 19673.0 19947.3 20203.8 24845.6 1025.8 1061.0 1077.5 1080.9 1084.3 10787.4 11154.9 11314.0 11575.0 11726.2 488411.0 491113.0 495614.0 497276.0 512225.0 129353.0 130244.0 131392.0 138399.0 138797.0 1228.4 1230.4 1260.9 1263.7 1268.5 21134.7 21311.5 21452.7 21637.2 21946.7 61574.4 61709.0 62397.0 63421.4 63525.0 79283.2 79749.0 79853.4 79971.6 80036.0 20253.0 20684.7 20790.0 20796.9 20835.2 23339.0 23689.9 23782.4 23797.5 23835.5 18217.7 18289.0 18511.4 18685.3 18685.9 16695.9 16858.5 16968.3 17039.7 17211.6 19068.7 19070.8 19121.9 19336.2 19351.8 20237.8 20297.0 20370.6 20421.5 20670.9 18430.0 18480.1 18521.1 18636.0 18636.5 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | [#3] mootools.html Cycles:180 Average:9379.92 Median:2602.69 stddev:6701.10 (257.5%) stddev-sans-first:6692.27 03:04:03 INFO - PID 2321 | Values: 1281.5 1326.5 1341.2 1346.8 1353.0 14704.4 15417.3 15426.7 15432.3 15569.2 15553.8 15890.0 15907.9 15922.4 15930.4 2750.2 2807.4 2814.4 2815.8 2817.7 2720.3 2810.3 2814.7 2814.9 2815.4 2729.9 2739.5 2745.4 2748.0 2765.3 2632.6 2645.6 2655.1 2669.0 2672.7 2589.7 2594.3 2601.2 2604.2 2609.7 14868.3 15161.7 15165.3 15168.8 15175.7 7799.6 8046.8 8062.6 8068.1 8082.9 5198.3 5306.3 5312.7 5395.4 5465.1 1953.3 1969.3 1999.5 2013.7 2021.6 25472.9 25647.4 25669.9 25732.0 25747.6 7059.0 7071.0 7376.2 7379.3 7394.6 17115.4 17201.3 17203.4 17263.7 17310.5 7687.8 7916.1 7916.1 7919.8 7922.0 7198.8 7285.3 7295.3 7314.0 7324.6 5062.0 5134.6 5160.3 5175.3 5204.6 1445.5 1449.3 1450.6 1457.0 1463.2 881.8 902.6 906.1 917.1 928.5 7564.8 7681.4 7728.4 7778.5 7830.5 722.2 723.8 726.2 986.2 1017.1 5210.1 5385.1 5541.7 5595.2 5715.4 21688.2 22443.8 22579.5 22580.9 22612.8 20766.4 21706.1 21978.3 22033.7 22059.1 11359.4 11680.3 11694.4 11743.3 11752.2 8439.6 8542.3 8641.3 8881.3 8985.3 18174.7 18445.6 18485.6 18719.4 18831.0 19048.7 19318.5 19360.7 19438.0 19498.7 12135.5 12173.1 12416.9 12429.4 12453.1 13879.6 13891.8 13923.8 13948.0 14000.0 10768.2 10854.0 10955.7 11004.8 11269.1 10834.3 10993.7 11012.6 11082.2 11279.3 9835.9 9882.0 9998.3 10001.2 10002.9 6725.3 6765.5 6821.7 6835.5 6881.0 6899.3 6992.0 6994.7 7020.5 7145.2 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | [#4] prototype.html Cycles:180 Average:5641.41 Median:6289.64 stddev:1579.73 (25.1%) stddev-sans-first:1536.48 03:04:03 INFO - PID 2321 | Values: 509.5 519.5 525.4 531.5 531.9 6313.0 6490.5 6514.5 6538.7 6546.6 6266.3 6395.5 6422.8 6435.2 6444.6 5249.8 5253.4 5286.9 5295.2 5320.5 5251.3 5274.6 5284.9 5307.3 5311.8 4918.3 5009.9 5075.8 5076.8 5079.3 5020.9 5052.8 5073.3 5078.9 5110.8 4374.4 4468.8 4548.1 4560.8 4567.9 6063.5 6102.8 6117.6 6173.4 6175.4 5788.0 5804.9 5857.8 5859.2 5860.9 6532.6 6633.3 6705.1 6715.9 6739.6 4974.7 4979.8 4987.8 4992.8 5017.5 6579.3 6800.9 6856.6 6991.3 7038.4 5049.9 5058.8 5062.3 5069.7 5102.6 5117.7 5149.5 5172.7 5210.4 5215.6 5748.7 5794.8 5800.8 5841.8 5852.4 6729.0 6746.2 6758.0 6809.6 6843.6 1778.3 1789.7 1794.6 1799.5 1801.6 1186.3 1213.4 1225.0 1236.7 1238.0 5887.5 5890.5 5919.5 5981.7 6009.7 6869.5 6909.8 6911.0 6986.9 7047.5 5901.9 5966.4 5983.8 5998.7 6010.8 3659.5 3659.5 3675.3 3676.9 3725.8 6635.4 6671.6 6674.5 6711.1 6733.4 6619.7 6927.3 6950.0 6980.0 7144.7 6613.2 6661.8 6682.3 6706.7 6714.0 6789.7 6887.2 6931.4 6962.4 6975.2 6720.0 6747.2 6784.2 6822.2 6867.5 6608.0 6626.0 6662.5 6664.4 6675.9 5046.7 5075.9 5109.6 5114.1 5114.8 6491.4 6704.7 6766.3 6837.1 6934.4 6445.5 6606.5 6659.8 6689.7 6714.9 6593.2 6596.8 6609.0 6708.2 6731.6 6577.6 6615.9 6665.7 6674.2 6747.0 6612.2 6691.0 6722.9 6790.8 6793.3 6462.9 6540.6 6589.4 6602.3 6612.1 03:04:03 INFO - PID 2321 | 03:04:03 INFO - PID 2321 | [#5] yui.html Cycles:180 Average:24091.28 Median:20648.33 stddev:32917.30 (159.4%) stddev-sans-first:32963.46 03:04:03 INFO - PID 2321 | Values: 868.8 898.1 899.2 899.4 917.4 17456.8 18684.8 19666.5 19677.2 19760.5 20527.2 20877.1 21305.9 21431.0 21461.9 953.1 960.4 960.9 964.7 965.2 960.1 981.1 983.0 989.5 991.2 1053.4 1054.3 1056.2 1056.4 1058.4 1050.6 1051.0 1051.1 1051.5 1053.7 770.9 771.1 771.8 772.2 772.6 19693.1 19780.5 19948.9 19969.2 20846.7 21292.7 21647.5 21655.8 21728.5 21812.8 16970.4 17022.5 17222.4 17224.7 17339.6 3740.7 3745.9 3759.2 3769.8 3770.5 121994.0 127179.7 130017.3 130159.0 132191.0 16763.9 17423.2 17455.7 17481.0 17581.1 30388.5 30485.8 30956.8 30970.0 31257.8 7606.3 7818.3 8706.9 9071.5 9370.4 4267.2 4365.5 4366.0 4375.9 4384.6 5306.5 5361.9 5379.7 5391.1 5453.3 1024.4 1031.7 1053.2 1056.9 1060.3 647.3 651.7 659.8 665.7 672.2 11384.7 11531.2 12106.0 13201.5 13583.9 654.5 657.8 667.6 671.7 683.9 5167.5 5422.2 5589.9 5642.3 5816.7 112728.4 113264.4 114525.0 114953.4 117824.0 97249.5 98416.5 99711.0 101607.0 101777.0 86023.6 86792.0 87031.0 87560.6 89530.6 10821.4 10836.3 11124.7 11153.7 12565.9 40308.2 40327.4 40374.4 41044.0 41816.8 67694.0 70100.3 71149.6 71791.0 75393.0 17696.9 18123.0 18166.6 18188.8 18229.9 19887.5 20156.7 20542.4 20636.4 20660.3 17948.8 18056.6 18091.6 18204.5 18307.0 17305.3 17701.1 17799.6 17842.0 17973.4 16051.2 16098.4 16209.3 16393.0 16725.9 13278.4 13758.7 13975.4 14123.6 14124.9 14108.0 14297.5 14340.8 14347.1 14373.4 03:04:03 INFO - PID 2321 | -------- Summary: end -------- 03:04:03 INFO - PID 2321 | 03:04:04 INFO - TEST-INFO | 2321: exit 0 03:04:04 INFO - TEST-OK | dromaeo_css | took 1111059ms 03:04:04 INFO - TEST-START | kraken 03:04:04 INFO - Initialising browser for kraken test... 03:04:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35621/getInfo.html -profile /tmp/tmpsy1dxw/profile 03:04:04 INFO - TEST-INFO | started process 2790 (/builds/slave/test/build/application/firefox/firefox http://localhost:35621/getInfo.html) 03:04:10 INFO - TEST-INFO | 2790: exit 0 03:04:10 INFO - Browser initialized. 03:04:10 INFO - Running cycle 1/1 for kraken test... 03:04:10 INFO - Using env: {'DISPLAY': ':0', 03:04:10 INFO - 'HOME': '/home/cltbld', 03:04:10 INFO - 'JSGC_DISABLE_POISONING': '1', 03:04:10 INFO - 'LANG': 'en_US.UTF-8', 03:04:10 INFO - 'LANGUAGE': 'en_US:en', 03:04:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:04:10 INFO - 'LOGNAME': 'cltbld', 03:04:10 INFO - 'MAIL': '/var/mail/cltbld', 03:04:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:04:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:04:10 INFO - 'MOZ_CRASHREPORTER': '1', 03:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:04:10 INFO - 'MOZ_NO_REMOTE': '1', 03:04:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:10 INFO - 'NO_EM_RESTART': '1', 03:04:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:10 INFO - 'PWD': '/builds/slave/test', 03:04:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:04:10 INFO - 'RUST_BACKTRACE': 'full', 03:04:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:04:10 INFO - 'SHELL': '/bin/bash', 03:04:10 INFO - 'SHLVL': '1', 03:04:10 INFO - 'STYLO_FORCE_ENABLED': '1', 03:04:10 INFO - 'TERM': 'linux', 03:04:10 INFO - 'TMOUT': '86400', 03:04:10 INFO - 'USER': 'cltbld', 03:04:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552', 03:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:10 INFO - '_': '/tools/buildbot/bin/python'} 03:04:10 INFO - TEST-INFO | started process 3059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsy1dxw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:11 INFO - PID 3059 | 03:04:11 INFO - PID 3059 | (/builds/slave/test/build/application/firefox/firefox:3135): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:04:11 INFO - PID 3059 | 03:04:21 INFO - PID 3059 | RSS: Main: 166436864 03:04:21 INFO - PID 3059 | 03:04:24 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35621/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:25 INFO - PID 3059 | RSS: Main: 172503040 03:04:25 INFO - PID 3059 | 03:04:28 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35621/tests/kraken/driver.html?testName=audio-dft) 03:04:28 INFO - PID 3059 | RSS: Main: 176275456 03:04:28 INFO - PID 3059 | 03:04:31 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35621/tests/kraken/driver.html?testName=audio-fft) 03:04:32 INFO - PID 3059 | RSS: Main: 169107456 03:04:32 INFO - PID 3059 | 03:04:34 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35621/tests/kraken/driver.html?testName=audio-oscillator) 03:04:35 INFO - PID 3059 | RSS: Main: 169598976 03:04:35 INFO - PID 3059 | 03:04:37 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35621/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:37 INFO - PID 3059 | RSS: Main: 169783296 03:04:37 INFO - PID 3059 | 03:04:40 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35621/tests/kraken/driver.html?testName=imaging-darkroom) 03:04:41 INFO - PID 3059 | RSS: Main: 170921984 03:04:41 INFO - PID 3059 | 03:04:45 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35621/tests/kraken/driver.html?testName=imaging-desaturate) 03:04:45 INFO - PID 3059 | RSS: Main: 170971136 03:04:45 INFO - PID 3059 | 03:04:48 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35621/tests/kraken/driver.html?testName=json-parse-financial) 03:04:49 INFO - PID 3059 | RSS: Main: 171151360 03:04:49 INFO - PID 3059 | 03:04:50 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35621/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:04:51 INFO - PID 3059 | RSS: Main: 171040768 03:04:51 INFO - PID 3059 | 03:04:53 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:04:53 INFO - PID 3059 | RSS: Main: 171044864 03:04:53 INFO - PID 3059 | 03:04:55 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:04:56 INFO - PID 3059 | RSS: Main: 170614784 03:04:56 INFO - PID 3059 | 03:04:59 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:04:59 INFO - PID 3059 | RSS: Main: 171220992 03:04:59 INFO - PID 3059 | 03:05:02 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:03 INFO - PID 3059 | RSS: Main: 171622400 03:05:03 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | Cycle 1(1): loaded http://localhost:35621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35621/tests/kraken/driver.html?testName=ai-astar) 03:05:05 INFO - PID 3059 | RSS: Main: 173346816 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | __start_tp_report 03:05:05 INFO - PID 3059 | _x_x_mozilla_page_load 03:05:05 INFO - PID 3059 | _x_x_mozilla_page_load_details 03:05:05 INFO - PID 3059 | |i|pagename|runs| 03:05:05 INFO - PID 3059 | |0;ai-astar;99;108;102;107;108;109;108;97;108;108 03:05:05 INFO - PID 3059 | |1;audio-beat-detection;148;117;141;176;115;142;147;116;166;117 03:05:05 INFO - PID 3059 | |2;audio-dft;164;163;161;160;160;161;165;171;166;161 03:05:05 INFO - PID 3059 | |3;audio-fft;76;76;73;151;74;73;74;87;104;73 03:05:05 INFO - PID 3059 | |4;audio-oscillator;79;78;133;80;80;79;122;79;79;138 03:05:05 INFO - PID 3059 | |5;imaging-gaussian-blur;115;114;113;115;114;114;114;114;114;114 03:05:05 INFO - PID 3059 | |6;imaging-darkroom;149;148;148;148;148;148;147;147;147;147 03:05:05 INFO - PID 3059 | |7;imaging-desaturate;94;94;93;94;94;93;93;94;94;94 03:05:05 INFO - PID 3059 | |8;json-parse-financial;52;51;52;51;52;52;53;52;51;52 03:05:05 INFO - PID 3059 | |9;json-stringify-tinderbox;38;38;38;37;38;38;38;39;38;37 03:05:05 INFO - PID 3059 | |10;stanford-crypto-aes;87;78;77;78;78;76;77;78;77;76 03:05:05 INFO - PID 3059 | |11;stanford-crypto-ccm;121;122;126;125;117;122;118;117;131;159 03:05:05 INFO - PID 3059 | |12;stanford-crypto-pbkdf2;177;188;177;172;183;178;171;170;176;172 03:05:05 INFO - PID 3059 | |13;stanford-crypto-sha256-iterative;71;65;75;64;62;68;63;64;65;63 03:05:05 INFO - PID 3059 | __end_tp_report 03:05:05 INFO - PID 3059 | __start_cc_report 03:05:05 INFO - PID 3059 | _x_x_mozilla_cycle_collect,929 03:05:05 INFO - PID 3059 | __end_cc_report 03:05:05 INFO - PID 3059 | __startTimestamp1504433105568__endTimestamp 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | ------- Summary: start ------- 03:05:05 INFO - PID 3059 | Number of tests: 14 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#0] ai-astar Cycles:10 Average:105.40 Median:108.00 stddev:4.38 (4.1%) stddev-sans-first:3.98 03:05:05 INFO - PID 3059 | Values: 99.0 108.0 102.0 107.0 108.0 109.0 108.0 97.0 108.0 108.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:144.50 stddev:21.93 (15.2%) stddev-sans-first:22.98 03:05:05 INFO - PID 3059 | Values: 148.0 117.0 141.0 176.0 115.0 142.0 147.0 116.0 166.0 117.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:3.46 (2.1%) stddev-sans-first:3.66 03:05:05 INFO - PID 3059 | Values: 164.0 163.0 161.0 160.0 160.0 161.0 165.0 171.0 166.0 161.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#3] audio-fft Cycles:10 Average:86.10 Median:74.00 stddev:24.82 (33.5%) stddev-sans-first:26.06 03:05:05 INFO - PID 3059 | Values: 76.0 76.0 73.0 151.0 74.0 73.0 74.0 87.0 104.0 73.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.35 (32.1%) stddev-sans-first:26.24 03:05:05 INFO - PID 3059 | Values: 79.0 78.0 133.0 80.0 80.0 79.0 122.0 79.0 79.0 138.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 03:05:05 INFO - PID 3059 | Values: 115.0 114.0 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 03:05:05 INFO - PID 3059 | Values: 149.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 147.0 147.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:05:05 INFO - PID 3059 | Values: 94.0 94.0 93.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 03:05:05 INFO - PID 3059 | Values: 52.0 51.0 52.0 51.0 52.0 52.0 53.0 52.0 51.0 52.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 03:05:05 INFO - PID 3059 | Values: 38.0 38.0 38.0 37.0 38.0 38.0 38.0 39.0 38.0 37.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:3.19 (4.1%) stddev-sans-first:0.83 03:05:05 INFO - PID 3059 | Values: 87.0 78.0 77.0 78.0 78.0 76.0 77.0 78.0 77.0 76.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:12.46 (10.1%) stddev-sans-first:13.10 03:05:05 INFO - PID 3059 | Values: 121.0 122.0 126.0 125.0 117.0 122.0 118.0 117.0 131.0 159.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:177.00 stddev:5.68 (3.2%) stddev-sans-first:6.02 03:05:05 INFO - PID 3059 | Values: 177.0 188.0 177.0 172.0 183.0 178.0 171.0 170.0 176.0 172.0 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.00 stddev:4.14 (6.4%) stddev-sans-first:3.97 03:05:05 INFO - PID 3059 | Values: 71.0 65.0 75.0 64.0 62.0 68.0 63.0 64.0 65.0 63.0 03:05:05 INFO - PID 3059 | -------- Summary: end -------- 03:05:05 INFO - PID 3059 | 03:05:05 INFO - PID 3059 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:05:06 INFO - TEST-INFO | 3059: exit 0 03:05:06 INFO - TEST-OK | kraken | took 61591ms 03:05:06 INFO - SUITE-END | took 1172s 03:05:06 INFO - Completed test suite (00:19:33) 03:05:06 INFO - javascript benchmark 03:05:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8702.791967773672, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.5010248462713, 3366.5623468949034, 3373.954074236987, 3377.3583019226353, 3397.0488263286275, 6428.32502587228, 6452.7096280667365, 6473.902891456626, 6494.0583615375745, 6536.986767051103, 6506.73973041079, 6526.053722210277, 6535.281119076898, 6537.411632953033, 6626.337366263371, 6040.335563088057, 6069.78755743549, 6083.604565703237, 6112.266528016644, 6118.082287656843, 5968.4031596840405, 6059.030555111183, 6111.847203819895, 6138.232720909887, 6155.538334624899, 5861.618994765348, 5962.314333851619, 5964.284285885678, 6017.157597936249, 6020.759169633209, 6033.577649564532, 6071.969640151771, 6090.939090609081, 6100.023996160593, 6105.8168254952425, 5975.40245975399, 5985.461308482214, 6010.909836352458, 6092.0, 6098.390160983866, 6340.017297318876, 6451.870962580769, 6544.116544266558, 6586.73653053882, 6638.5684930479365, 6975.337342952462, 7023.122109736283, 7024.613646249454, 7032.0, 7032.296770322978, 7124.679389427488, 7163.0688010558815, 7212.423006159494, 7217.422606191492, 7218.639068046629, 6532.575382600164, 6552.312007239267, 6552.3447655234095, 6634.834129146761, 6636.634985075867, 7031.296870312928, 7161.606111663804, 7171.713131474787, 7235.710571577078, 7302.744403945836, 6943.618101004392, 6948.478864085214, 6954.582725036514, 6997.860042799217, 7002.01971723959, 7016.193137789118, 7035.753748618774, 7120.821979450555, 7122.28777122294, 7136.0, 7002.579845209304, 7004.579725216503, 7022.894656580155, 7096.503244772816, 7100.076989991371, 6912.481563882729, 7004.0, 7027.824304392431, 7029.3673569379, 7073.328033836778, 5490.890182196414, 5532.280803495601, 5543.7782488700805, 5559.471850174227, 5571.387147413781, 4847.079054979543, 4847.442544107403, 4857.0043141155975, 4912.263160525878, 4932.55606995365, 5980.491658209101, 6111.8472038198515, 6114.694265286718, 6188.793185328907, 6196.783112591038, 6997.7200911962955, 7053.858922821515, 7116.359527642537, 7120.181179164462, 7123.5369700970305, 6121.602095863755, 6146.569740118238, 6154.78458253959, 6165.907511387333, 6180.3201647818705, 6008.128821320884, 6020.909686354708, 6068.848278793065, 6080.513558915276, 6091.817245482643, 6777.898331525031, 6789.1174147360525, 6888.138982627172, 6901.275366086488, 6922.7923162305215, 6847.726090956506, 7005.6146911918295, 7014.929850701427, 7102.325279098477, 7109.075820143556, 6693.598384096969, 6756.966215168893, 6810.455163587, 6830.658467076527, 6838.247792742894, 6863.10779598669, 6889.724411023703, 6912.343327383891, 6961.965190174017, 6985.650717464005, 7104.857902842017, 7106.5736055836815, 7153.535020223669, 7170.960210769514, 7197.496175267681, 6663.46692264608, 6777.423918966943, 6783.084283621648, 6810.28492008332, 6872.725090996304, 6679.532432729662, 6693.0, 6717.193936727624, 6748.93251067483, 6854.246032936473, 6714.328567143247, 6760.1549806274215, 6760.18877734675, 6762.323767623198, 6790.015447760146, 6827.829304267234, 6884.759033433806, 6908.274631163656, 6923.9653801730665, 6938.06336144614, 6470.255920569007, 6537.5096867736065, 6598.571092878948, 6608.041833934149, 6677.131972843499], "value": 6414.357765563344, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.778685861388, 846.2510678049925, 864.0883867519766, 884.363258453913, 1131.9094472442205, 30773.23066923328, 31418.842905785466, 40584.39123413151, 40829.795851020775, 41014.58985410145, 40994.59005409953, 41493.37759933603, 41512.0, 41534.37698434518, 41548.79225603875, 7268.527545709539, 7664.0, 7897.526148431112, 7898.0, 7917.445778795487, 7627.580483073429, 7729.845403091935, 7747.2640099190485, 7751.689932402697, 7761.340286075662, 7747.9612601936915, 7786.26030527099, 7812.179721129285, 7840.13758486566, 7871.8032049198655, 7807.063152421717, 7809.258120478546, 7825.804354891116, 7845.921540784576, 7847.489913155655, 7730.613469326511, 7789.10425301092, 7790.182030886732, 7790.649420776079, 7798.103218129931, 36812.89561313165, 37295.25409491795, 37323.25353492915, 37367.813160934296, 37458.43812342817, 3564.2515071834946, 3626.8005259710703, 3626.9818650906577, 3630.3283892479712, 3633.4913112164318, 31394.843025784954, 31483.055508334786, 31483.685163148304, 31490.685093149004, 31538.842305788323, 5030.798768049273, 5157.071727089123, 5173.430922598511, 5186.922196167023, 5199.948000519984, 184155.0, 184644.0, 185001.0, 185751.0, 186111.06944465326, 47609.0, 47647.52352476431, 47756.5224347759, 47779.0, 47873.76063119662, 49434.25848612274, 49584.0, 49637.75181124071, 49713.25430118479, 49895.50104498981, 14472.493462728755, 15925.0, 16196.838031619769, 16288.0, 16288.185590720417, 12109.091818113677, 13228.272445015424, 13340.799888001688, 13355.532556360675, 13361.398737056856, 13536.796948045787, 13647.249401282827, 13683.179009259477, 13773.242471664154, 13831.100978436369, 5435.972820135874, 5508.256385388001, 5515.821250605988, 5524.613277070647, 5555.666660000413, 984.1782111936614, 990.895955924632, 994.4480813148772, 1012.2408193854609, 1029.8300780371305, 21676.24133155332, 22048.0, 22100.447488812908, 22113.336599901708, 22460.10159593598, 1074.2641290715885, 1076.8976947190004, 1093.7265683579105, 1093.94530273486, 1101.30067407197, 11697.590584329508, 11758.176927615155, 11822.172447928735, 11863.76272474563, 11982.700432489084, 226975.0, 227898.0, 228393.0, 228536.0, 229945.0, 48947.755261223465, 49034.264486032735, 49067.754661227176, 49418.0, 49525.0, 1410.8941829362839, 1425.771876499755, 1447.3848614339074, 1452.7820826876052, 1458.5478501664518, 21035.789642103384, 21348.57302853903, 21669.783302166776, 21736.891315543322, 21855.78144218601, 35680.0, 35950.820245898605, 35999.82000090087, 36073.45889811603, 36103.27793444064, 202321.0, 203836.0, 203866.0, 204638.0, 204920.0, 32408.675913240564, 32674.183145421553, 34800.65199347974, 36622.0, 36735.448968266035, 45434.31848522341, 46539.0, 46631.766841165576, 46649.53350466588, 47438.288425674335, 32982.0, 33002.66997329996, 33122.83438582792, 33206.16984575405, 33701.15747106342, 33490.0, 33734.83132584322, 33828.15429614279, 34058.318833623685, 34461.827690861384, 36970.0, 37865.432018520296, 37959.81020094882, 38124.0, 38262.42606360962, 31871.0, 32777.50833737448, 32984.505232421056, 33023.66976330206, 33801.83099084489, 23707.0, 24129.155479558132, 24167.274981749873, 24280.878595606908, 24362.756372436048], "value": 17080.21919529966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6640249051812, 576.1242910775621, 578.9739461724222, 595.2291782142125, 602.9638221706697, 22424.88787556062, 22784.43038924028, 23169.420764480856, 23240.41898952527, 23282.88358558207, 25521.489570208632, 25766.74233257667, 25848.0, 25879.61180582293, 26318.0, 6757.358050985161, 6876.277990810968, 6898.896516552256, 6901.171859376882, 6910.412614927737, 6039.275286965571, 6623.966880165616, 6640.833979150536, 6649.634270115142, 6805.761798337059, 6511.57674751142, 6514.315996820336, 6539.705713242892, 6542.182227221598, 6598.538102332838, 6513.348665133472, 6524.412802847743, 6525.869482610368, 6553.967230163867, 6590.538662293641, 6118.4799292060225, 6123.418275263887, 6133.754649814002, 6141.048137538644, 6152.107944348089, 28212.0, 28809.423811523862, 29253.0, 29354.41291174186, 29549.261268468246, 2042.101475350841, 2072.367927782026, 2073.39871437283, 2074.159965214091, 2075.2217918280644, 19196.520086997796, 19835.10742016613, 19839.504012399662, 19846.801531984784, 19914.40256792284, 2374.0820395745754, 2395.6765836612008, 2404.230646193219, 2406.9398265043337, 2440.9755902440925, 134982.0, 137714.0, 140337.0, 140420.0, 140986.29506852504, 14481.710365792625, 14737.336819842918, 14756.934029235916, 14819.851801481847, 15696.293666784793, 23181.536369272857, 23286.417839554146, 23306.417339566648, 23344.533109337717, 23353.766462335498, 10247.487625618689, 10404.167666586654, 10584.153267738562, 10615.416152111553, 10854.728631784268, 7704.383649308042, 9884.901150988542, 9901.108900199017, 9962.452065136487, 10050.346727462691, 7971.242731940572, 9137.451752894847, 9184.173424391836, 9209.815803683889, 9414.482203478738, 2604.5442047641586, 2684.5302072137297, 2704.2428120126397, 2708.349996000946, 2810.873510692024, 952.8808898887639, 969.8351280282369, 978.7406337320616, 978.8238117138983, 980.8970058143935, 19401.902990484956, 19673.01634918277, 19947.301844435377, 20203.79796202019, 24845.62731559028, 1025.8204814157493, 1060.989390106089, 1077.498962982217, 1080.8702955645374, 1084.2572837606265, 10787.352758834495, 11154.944225278821, 11313.981741643292, 11575.016123629586, 11726.179167458196, 488411.0, 491113.0, 495614.0, 497276.0, 512225.0, 129353.0, 130244.0, 131392.0, 138399.0, 138797.0, 1228.3858070964518, 1230.3540641163281, 1260.9495620175273, 1263.6777621706406, 1268.4862630634607, 21134.68297975501, 21311.467213319793, 21452.712837229818, 21637.242696505546, 21946.670799938332, 61574.38425615687, 61709.0, 62397.0, 63421.36578634154, 63525.0, 79283.20716792758, 79749.0, 79853.40659670213, 79971.60014199892, 80036.0, 20253.0, 20684.689729653765, 20790.0, 20796.896015519826, 20835.166593336096, 23339.0, 23689.881550592138, 23782.405439864142, 23797.524049518568, 23835.523289533765, 18217.726734098735, 18289.0, 18511.444656660322, 18685.346012889484, 18685.90657046706, 16695.91652041732, 16858.539505187648, 16968.32126714967, 17039.744403833705, 17211.569710757332, 19068.713969290195, 19070.80929190746, 19121.904390477957, 19336.22655093837, 19351.806481935, 20237.79762202418, 20297.0, 20370.57405981567, 20421.489462762955, 20670.896645516677, 18430.0, 18480.075996200405, 18521.07394630236, 18636.0, 18636.534086647942], "value": 12526.266709887917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.5130250504808, 1326.5091915991081, 1341.2489006156552, 1346.7575836349454, 1352.9526466573666, 14704.41182352706, 15417.306221220044, 15426.69146617067, 15432.305546250418, 15569.221538923066, 15553.766693499578, 15890.0, 15907.920460397681, 15922.363105475768, 15930.442434514795, 2750.22993561803, 2807.410443806803, 2814.408974115438, 2815.831050136988, 2817.7464028237455, 2720.319920019995, 2810.297425643589, 2814.6763122240895, 2814.887404503828, 2815.3524689321466, 2729.863506824651, 2739.4521095780924, 2745.3960128771637, 2747.972520274792, 2765.3363192833776, 2632.5656266716064, 2645.5899335603012, 2655.0972669292437, 2669.0391459074717, 2672.7327267273313, 2589.741025897414, 2594.286571192918, 2601.1546247469646, 2604.2187343796973, 2609.7259787722205, 14868.330925108396, 15161.696766064617, 15165.317560709684, 15168.772468412983, 15175.696486070217, 7799.649015794246, 8046.758597242092, 8062.556559389232, 8068.072171700271, 8082.919170808275, 5198.298229738974, 5306.310179676656, 5312.654677445954, 5395.433479484676, 5465.125579907235, 1953.2870502266712, 1969.3008981811538, 1999.5201151723627, 2013.6878783788536, 2021.5754691514799, 25472.872635636704, 25647.358816029562, 25669.871650641813, 25732.0, 25747.613785793415, 7058.964705176441, 7071.003124673963, 7376.225496322916, 7379.262073792578, 7394.630268486554, 17115.400960966308, 17201.311947521957, 17203.397881074103, 17263.654726905643, 17310.480685579452, 7687.807804804813, 7916.050073991158, 7916.089649690244, 7919.802004949807, 7922.049354077432, 7198.820029499199, 7285.344319011315, 7295.343419092307, 7313.963430182815, 7324.63376831167, 5062.0, 5134.589232861362, 5160.251763494272, 5175.301334319819, 5204.583633309327, 1445.4651778841896, 1449.282605110477, 1450.6155868694805, 1456.992715036418, 1463.231803303253, 881.828043531518, 902.6028547439106, 906.1165363770403, 917.0691747875911, 928.4661319741176, 7564.848703025908, 7681.42389320792, 7728.381729461629, 7778.533288002738, 7830.451868369273, 722.1695050691746, 723.8371366442614, 726.1576571177409, 986.2455221755363, 1017.0592202212923, 5210.140326846028, 5385.057614917374, 5541.695206763586, 5595.160725891067, 5715.428457154251, 21688.24091156802, 22443.775562244497, 22579.548409031726, 22580.887095564416, 22612.773872261067, 20766.377008689764, 21706.131754729635, 21978.340649780534, 22033.669494957587, 22059.11763529441, 11359.375234362024, 11680.299182049104, 11694.415279236004, 11743.295402275891, 11752.177347585757, 8439.620217090369, 8542.26924633208, 8641.308695304235, 8881.289496840367, 8985.326100542616, 18174.72737908959, 18445.631087378446, 18485.630287394444, 18719.438416847515, 18831.0, 19048.714269285694, 19318.517037074187, 19360.70958935645, 19438.0, 19498.707519386935, 12135.453904574491, 12173.087018473472, 12416.937915310365, 12429.378531073591, 12453.128281020241, 13879.583612491642, 13891.791623125864, 13923.791143133063, 13948.0, 14000.0, 10768.192385570957, 10854.023137917626, 10955.726106847074, 11004.834927476255, 11269.098472122047, 10834.295770774874, 10993.670189894316, 11012.559497620005, 11082.16883733707, 11279.266847654877, 9835.852462213215, 9881.950590247003, 9998.25013124004, 10001.249906257206, 10002.899971000197, 6725.260221375547, 6765.492588055817, 6821.727130914708, 6835.453163746988, 6881.0, 6899.275576064441, 6992.0, 6994.720211191496, 7020.508564400443, 7145.1783044948415], "value": 6672.989805314598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.454883274896, 519.4545726986664, 525.3669328459207, 531.4950796743095, 531.9202119682047, 6312.9684351578235, 6490.480761539072, 6514.478841692665, 6538.705758240879, 6546.607203567777, 6266.310705822356, 6395.488360931126, 6422.775202867901, 6435.227772667275, 6444.645544495051, 5249.845034092503, 5253.4221235664045, 5286.867828304285, 5295.20571914214, 5320.467953204688, 5251.264822924793, 5274.604404669646, 5284.904199245596, 5307.336582927134, 5311.840644780663, 4918.336024636664, 5009.874753131165, 5075.817398518636, 5076.796928122871, 5079.3142925705115, 5020.899582008357, 5052.8484145475695, 5073.315102461157, 5078.898422031539, 5110.8466745997675, 4374.365716971053, 4468.82124715011, 4548.135854187693, 4560.794764235618, 4567.862964111082, 6063.514918806485, 6102.7864024759365, 6117.632942023492, 6173.351798061184, 6175.382461753834, 5787.971060144672, 5804.9419505805245, 5857.824265272048, 5859.238299021143, 5860.912086318709, 6532.5753826001155, 6633.30350313215, 6705.1283333166375, 6715.899261511081, 6739.59562426256, 4974.726390048546, 4979.751012449363, 4987.825426110105, 4992.775325110379, 5017.48775856898, 6579.309172536862, 6800.863982720318, 6856.554323968926, 6991.265917078685, 7038.401735852459, 5049.924251136236, 5058.772355244023, 5062.341895553628, 5069.670471419419, 5102.591792656579, 5117.722613436985, 5149.48505149482, 5172.6551096714375, 5210.374755029421, 5215.58275337972, 5748.7125643717645, 5794.82615521535, 5800.767969281266, 5841.766329346863, 5852.4147585241135, 6728.966355168192, 6746.224184218878, 6757.966210168917, 6809.638072385543, 6843.589384636838, 1778.288684526174, 1789.702465712374, 1794.6450429925324, 1799.4781513360979, 1801.5766294920684, 1186.323795436593, 1213.4296880466168, 1224.9571265005682, 1236.6722818453118, 1237.9690507737198, 5887.499562537232, 5890.469857712741, 5919.467247947706, 5981.700914954235, 6009.737955029405, 6869.484788640872, 6909.827254318581, 6910.965445172742, 6986.895196572055, 7047.471439642048, 5901.937651222821, 5966.373530779292, 5983.820485385445, 5998.730057147439, 6010.789622363283, 3659.469376940329, 3659.4876717259604, 3675.2649470106085, 3676.889693309205, 3725.795081270502, 6635.402813746786, 6671.5997040177745, 6674.532782705164, 6711.127553418024, 6733.360330768569, 6619.735210591522, 6927.307269273133, 6949.992251123559, 6979.953007048984, 7144.678489467987, 6613.222446572548, 6661.800145995628, 6682.331766823376, 6706.698198580978, 6714.0, 6789.72841086351, 6887.20797108339, 6931.376176144171, 6962.443004559522, 6975.162980442379, 6720.0, 6747.190337159573, 6784.151981002375, 6822.249552549315, 6867.519273650796, 6608.0, 6625.958165519126, 6662.533622646368, 6664.400203981665, 6675.899861501985, 5046.6719663221775, 5075.908679633896, 5109.565686916654, 5114.1305977984575, 5114.769835357343, 6491.350864913471, 6704.7318107277115, 6766.289539598468, 6837.1111755471475, 6934.410575100971, 6445.452136568444, 6606.471482281502, 6659.800205993828, 6689.732410703517, 6714.865702685821, 6593.208814942238, 6596.769113081211, 6608.966955165193, 6708.228553716385, 6731.629760363031, 6577.572457790228, 6615.900761488678, 6665.733370665119, 6674.16572928384, 6746.966265168643, 6612.239592446737, 6691.0, 6722.899156512754, 6790.796276111724, 6793.320667933365, 6462.870742585216, 6540.574862633914, 6589.374009469093, 6602.306757790555, 6612.107365505595], "value": 5173.475029033152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.7741187291306, 898.1377877237851, 899.2221728205101, 899.4108858697556, 917.4266083697692, 17456.825431745678, 18684.81315186848, 19666.508337291576, 19677.212911483522, 19760.505987350287, 20527.178912843505, 20877.060532276046, 21305.893470532625, 21431.0, 21461.892690536566, 953.1278879824952, 960.4237457525498, 960.8558716192592, 964.7057647417535, 965.242284806427, 960.1071003966308, 981.0728861226144, 982.9508524573779, 989.4953573677441, 991.2268430624089, 1053.441675911768, 1054.3305001324138, 1056.1761825775907, 1056.4031322302912, 1058.4284486377346, 1050.6480329089763, 1051.0225490294024, 1051.0855555666542, 1051.5057922776282, 1053.7418332508507, 770.938324934004, 771.0708596141692, 771.7993321736388, 772.2277722277722, 772.5596410046276, 19693.11380987859, 19780.50548736279, 19948.900255498775, 19969.201231950705, 20846.68729969052, 21292.680609790867, 21647.45881352963, 21655.783442165535, 21728.456788580253, 21812.781872181233, 16970.40603578869, 17022.48932532026, 17222.397216097375, 17224.741628875578, 17339.566510837205, 3740.682042026431, 3745.887623371276, 3759.248150369937, 3769.754965927206, 3770.453284273765, 121994.0, 127179.72820271771, 130017.34991325077, 130159.0, 132190.99999999904, 16763.91618041902, 17423.21595528204, 17455.73816392755, 17481.0, 17581.120943953007, 30388.54417183744, 30485.84757076245, 30956.84521577423, 30970.0, 31257.8437107813, 7606.315431611181, 7818.296353328114, 8706.869396959051, 9071.455712657262, 9370.437773733598, 4267.16790225903, 4365.541618130114, 4365.956340436618, 4375.934360984587, 4384.6273066789045, 5306.52241298285, 5361.919571206435, 5379.67721936685, 5391.110466772939, 5453.318335208099, 1024.4314405504867, 1031.7162780235494, 1053.2258789789498, 1056.8573242612304, 1060.2737125069352, 647.2976820150095, 651.6643928376795, 659.7954634063456, 665.70043480434, 672.1765836849918, 11384.658460246206, 11531.192816502764, 12106.0, 13201.47194112244, 13583.932080339733, 654.502578040683, 657.7500549791145, 667.5994403357946, 671.684308375063, 683.9452843772486, 5167.483251674803, 5422.186671999231, 5589.916151257735, 5642.322921249476, 5816.738246778905, 112728.43635781769, 113264.43367783273, 114525.0, 114953.4252328733, 117824.0, 97249.51375243078, 98416.50791745995, 99711.00577988545, 101607.0, 101777.0, 86023.56988215019, 86792.0, 87031.0, 87560.56219718988, 89530.55234723784, 10821.350718956573, 10836.295640783324, 11124.721881952692, 11153.665390038312, 12565.87434125647, 40308.178427509796, 40327.39508907427, 40374.39438408367, 41044.0, 41816.790916045225, 67694.0, 70100.29899700938, 71149.64425178048, 71791.0, 75393.0, 17696.911515442855, 18123.0, 18166.636667266845, 18188.81811181924, 18229.908850455664, 19887.502812429804, 20156.697649534974, 20542.38372848817, 20636.380908572766, 20660.276890308767, 17948.820511794715, 18056.638867222846, 18091.638167236844, 18204.45386638403, 18307.0, 17305.30778768835, 17701.114944252993, 17799.644007119525, 17842.0, 17973.37093201732, 16051.19744012818, 16098.356065757238, 16209.270582823565, 16393.0, 16725.916370418556, 13278.402471888981, 13758.65603359924, 13975.440982360591, 14123.64690882736, 14124.929375353058, 14108.0, 14297.499587514387, 14340.784888226894, 14347.139171649735, 14373.353199105855], "value": 9169.713138335917, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 102.0, 107.0, 108.0, 109.0, 108.0, 97.0, 108.0, 108.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 141.0, 176.0, 115.0, 142.0, 147.0, 116.0, 166.0, 117.0], "value": 138.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 161.0, 160.0, 160.0, 161.0, 165.0, 171.0, 166.0, 161.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 73.0, 151.0, 74.0, 73.0, 74.0, 87.0, 104.0, 73.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 133.0, 80.0, 80.0, 79.0, 122.0, 79.0, 79.0, 138.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 51.0, 52.0, 52.0, 53.0, 52.0, 51.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 39.0, 38.0, 37.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 77.0, 78.0, 78.0, 76.0, 77.0, 78.0, 77.0, 76.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 126.0, 125.0, 117.0, 122.0, 118.0, 117.0, 131.0, 159.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 188.0, 177.0, 172.0, 183.0, 178.0, 171.0, 170.0, 176.0, 172.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 75.0, 64.0, 62.0, 68.0, 63.0, 64.0, 65.0, 63.0], "value": 66.0, "unit": "score"}]}]} 03:05:06 INFO - Return code: 0 03:05:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:05:06 INFO - # TBPL SUCCESS # 03:05:06 INFO - Running post-action listener: _package_coverage_data 03:05:06 INFO - Running post-action listener: _resource_record_post_action 03:05:06 INFO - [mozharness: 2017-09-03 10:05:06.863551Z] Finished run-tests step (success) 03:05:06 INFO - Running post-run listener: _resource_record_post_run 03:05:06 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 40960; Write bytes: 391856128; Read time: 516; Write time: 282508 03:05:06 INFO - TinderboxPrint: CPU usage
13.1% 03:05:06 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 516 03:05:06 INFO - TinderboxPrint: I/O write bytes / time
391,856,128 / 282,508 03:05:06 INFO - TinderboxPrint: CPU idle
8,243.2 (86.9%) 03:05:06 INFO - TinderboxPrint: CPU user
1,193.0 (12.6%) 03:05:06 INFO - TinderboxPrint: Swap in / out
0 / 0 03:05:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 8192; Write bytes: 99074048; Read time: 252; Write time: 81004 03:05:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:05:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 32768; Write bytes: 284663808; Read time: 264; Write time: 200716 03:05:07 INFO - Running post-run listener: _upload_blobber_files 03:05:07 INFO - Blob upload gear active. 03:05:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:05:07 INFO - (blobuploader) - INFO - Open directory for files ... 03:05:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:05:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:14 INFO - (blobuploader) - INFO - Done attempting. 03:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:15 INFO - (blobuploader) - INFO - Done attempting. 03:05:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:05:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:17 INFO - (blobuploader) - INFO - Done attempting. 03:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:18 INFO - (blobuploader) - INFO - Done attempting. 03:05:18 INFO - (blobuploader) - INFO - Iteration through files over. 03:05:18 INFO - Return code: 0 03:05:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:05:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:05:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ca2a7bb185c5eadbe54de1c48e57ca61cf56c1cfff1179aecb3e4c1613bff11a5714a0c6aa64641c4aea8c3db66d79a227a819cdebcfcf0e5cfb15ce0baf86", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6021bd9a08d589debc882a7171e0f68ea5e866171046148e3b284fd3b9c4f609c1c9f0adfbeacab26a31cb8ed3425c700eba9d264b4c8698d10c53a2cc6ec7f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07075fd7ca174a7a812b4e4aa2c1cb9460e8ad598700167f5f6919a9bd28e31da1e89d2d2598120900dc9fb7596a9db7a367be3f99286298d76cee5862d57119", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc4896c7150d622078c92a979a4bbaee64d3b9cab6aee1c603acebce0baa56ee9a972aa4b16c710068cd5890daf7ddafe261ad7b47d2fe9261d638b55555feb0"} 03:05:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:05:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:05:18 INFO - Contents: 03:05:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ca2a7bb185c5eadbe54de1c48e57ca61cf56c1cfff1179aecb3e4c1613bff11a5714a0c6aa64641c4aea8c3db66d79a227a819cdebcfcf0e5cfb15ce0baf86", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6021bd9a08d589debc882a7171e0f68ea5e866171046148e3b284fd3b9c4f609c1c9f0adfbeacab26a31cb8ed3425c700eba9d264b4c8698d10c53a2cc6ec7f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07075fd7ca174a7a812b4e4aa2c1cb9460e8ad598700167f5f6919a9bd28e31da1e89d2d2598120900dc9fb7596a9db7a367be3f99286298d76cee5862d57119", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc4896c7150d622078c92a979a4bbaee64d3b9cab6aee1c603acebce0baa56ee9a972aa4b16c710068cd5890daf7ddafe261ad7b47d2fe9261d638b55555feb0"} 03:05:18 INFO - Running post-run listener: copy_logs_to_upload_dir 03:05:18 INFO - Copying logs to upload dir... 03:05:18 INFO - mkdir: /builds/slave/test/build/upload/logs 03:05:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.553368 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-03 03:05:18.652146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:18.656207) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ca2a7bb185c5eadbe54de1c48e57ca61cf56c1cfff1179aecb3e4c1613bff11a5714a0c6aa64641c4aea8c3db66d79a227a819cdebcfcf0e5cfb15ce0baf86", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6021bd9a08d589debc882a7171e0f68ea5e866171046148e3b284fd3b9c4f609c1c9f0adfbeacab26a31cb8ed3425c700eba9d264b4c8698d10c53a2cc6ec7f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07075fd7ca174a7a812b4e4aa2c1cb9460e8ad598700167f5f6919a9bd28e31da1e89d2d2598120900dc9fb7596a9db7a367be3f99286298d76cee5862d57119", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc4896c7150d622078c92a979a4bbaee64d3b9cab6aee1c603acebce0baa56ee9a972aa4b16c710068cd5890daf7ddafe261ad7b47d2fe9261d638b55555feb0"} build_url:https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/K9R3fxHzShCqGda311qAQg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7ca2a7bb185c5eadbe54de1c48e57ca61cf56c1cfff1179aecb3e4c1613bff11a5714a0c6aa64641c4aea8c3db66d79a227a819cdebcfcf0e5cfb15ce0baf86", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6021bd9a08d589debc882a7171e0f68ea5e866171046148e3b284fd3b9c4f609c1c9f0adfbeacab26a31cb8ed3425c700eba9d264b4c8698d10c53a2cc6ec7f0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/07075fd7ca174a7a812b4e4aa2c1cb9460e8ad598700167f5f6919a9bd28e31da1e89d2d2598120900dc9fb7596a9db7a367be3f99286298d76cee5862d57119", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc4896c7150d622078c92a979a4bbaee64d3b9cab6aee1c603acebce0baa56ee9a972aa4b16c710068cd5890daf7ddafe261ad7b47d2fe9261d638b55555feb0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:18.685033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:18.685357) ========= 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=03627c79f6bb3d1578c4a402000001ba-1504408022.656064-1066100552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-03 03:05:18.768884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-03 03:05:18.769207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-03 03:05:18.769523) ========= ========= Total master_lag: 0.23 =========