builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1506508765.27 results: success (0) revision: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.274292) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.274737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.275283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.335590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.335833) ========= 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=745a4373a2a16df560f216e000000264-1506507987.780939-191415187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 03:39:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-09-27 03:39:25 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071615 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.435105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.435386) ========= 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=745a4373a2a16df560f216e000000264-1506507987.780939-191415187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015678 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:25.490411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-27 03:39:25.490710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 --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 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 --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=745a4373a2a16df560f216e000000264-1506507987.780939-191415187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 03:39:25,557 truncating revision to first 12 chars 2017-09-27 03:39:25,557 Setting DEBUG logging. 2017-09-27 03:39:25,557 attempt 1/10 2017-09-27 03:39:25,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5563e7da39b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 03:39:26,242 attempt 1/10 2017-09-27 03:39:27,067 current task status: no status available at this point. state: STARTED 2017-09-27 03:39:27,067 sleeping for 9.00s (attempt 1/10) 2017-09-27 03:39:36,077 attempt 2/10 2017-09-27 03:39:36,419 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-27 03:39:36,597 unpacking tar archive at: mozilla-central-5563e7da39b2/testing/mozharness/ program finished with exit code 0 elapsedTime=11.328366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-09-27 03:39:36.841243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:36.841552) ========= script_repo_revision: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:36.844932) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:36.845203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 03:39:36.862617) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-27 03:39:36.863008) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=745a4373a2a16df560f216e000000264-1506507987.780939-191415187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:39:37 INFO - MultiFileLogger online at 20170927 03:39:37 in /builds/slave/test 03:39:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:39:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:37 INFO - {'append_to_log': False, 03:39:37 INFO - 'base_work_dir': '/builds/slave/test', 03:39:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:39:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:37 INFO - 'branch': 'Firefox-Non-PGO', 03:39:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:37 INFO - 'code_coverage': False, 03:39:37 INFO - 'config_files': ('talos/linux_config.py',), 03:39:37 INFO - 'default_actions': ('clobber', 03:39:37 INFO - 'read-buildbot-config', 03:39:37 INFO - 'download-and-extract', 03:39:37 INFO - 'populate-webroot', 03:39:37 INFO - 'create-virtualenv', 03:39:37 INFO - 'install', 03:39:37 INFO - 'setup-mitmproxy', 03:39:37 INFO - 'run-tests'), 03:39:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:37 INFO - 'disable_ccov_upload': False, 03:39:37 INFO - 'disable_stylo': False, 03:39:37 INFO - 'download_minidump_stackwalk': True, 03:39:37 INFO - 'download_symbols': 'ondemand', 03:39:37 INFO - 'enable_stylo': False, 03:39:37 INFO - 'enable_webrender': False, 03:39:37 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:39:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:37 INFO - 'gecko_profile': False, 03:39:37 INFO - 'gecko_profile_interval': 0, 03:39:37 INFO - 'installer_path': 'installer.exe', 03:39:37 INFO - 'log_level': 'info', 03:39:37 INFO - 'log_name': 'talos', 03:39:37 INFO - 'log_to_console': True, 03:39:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:39:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:39:37 INFO - 'opt_config_files': (), 03:39:37 INFO - 'pip_index': False, 03:39:37 INFO - 'suite': 'dromaeojs-e10s', 03:39:37 INFO - 'system_bits': '32', 03:39:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:37 INFO - 'title': 'talos-linux64-ix-032', 03:39:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:37 INFO - 'use_talos_json': True, 03:39:37 INFO - 'verify': 'False', 03:39:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:37 INFO - 'work_dir': 'build'} 03:39:37 INFO - [mozharness: 2017-09-27 10:39:37.068184Z] Running clobber step. 03:39:37 INFO - Running pre-action listener: _resource_record_pre_action 03:39:37 INFO - Running main action method: clobber 03:39:37 INFO - rmtree: /builds/slave/test/build 03:39:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:38 INFO - Running post-action listener: _resource_record_post_action 03:39:38 INFO - [mozharness: 2017-09-27 10:39:38.586341Z] Finished clobber step (success) 03:39:38 INFO - [mozharness: 2017-09-27 10:39:38.586440Z] Running read-buildbot-config step. 03:39:38 INFO - Running pre-action listener: _resource_record_pre_action 03:39:38 INFO - Running main action method: read_buildbot_config 03:39:38 INFO - Using buildbot properties: 03:39:38 INFO - { 03:39:38 INFO - "project": "", 03:39:38 INFO - "product": "firefox", 03:39:38 INFO - "who": "archaeopteryx@coole-files.de", 03:39:38 INFO - "installer_path": "public/build/target.tar.bz2", 03:39:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:39:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:39:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:39:38 INFO - "stage_platform": "linux64", 03:39:38 INFO - "basedir": "/builds/slave/test", 03:39:38 INFO - "buildnumber": 871, 03:39:38 INFO - "platform": "ubuntu64_hw", 03:39:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:39:38 INFO - "slavebuilddir": "test", 03:39:38 INFO - "taskId": "HOlJkYNdTgKuUwo8K0lubQ", 03:39:38 INFO - "branch": "mozilla-central", 03:39:38 INFO - "script_repo_revision": "production", 03:39:38 INFO - "revision": "5563e7da39b265ed1ba7796ec058bdbcf6f792f6", 03:39:38 INFO - "slavename": "talos-linux64-ix-032", 03:39:38 INFO - "repo_path": "mozilla-central" 03:39:38 INFO - } 03:39:38 INFO - Finding installer, test and symbols from parent task. 03:39:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HOlJkYNdTgKuUwo8K0lubQ'}, attempt #1 03:39:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HOlJkYNdTgKuUwo8K0lubQ'}, attempt #1 03:39:39 INFO - Task dependencies: Epxi0CdYQW63JHszs_NJbg 03:39:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg'}, attempt #1 03:39:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2 03:39:40 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.test_packages.json 03:39:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.crashreporter-symbols.zip 03:39:40 INFO - Running post-action listener: _resource_record_post_action 03:39:40 INFO - [mozharness: 2017-09-27 10:39:40.012131Z] Finished read-buildbot-config step (success) 03:39:40 INFO - [mozharness: 2017-09-27 10:39:40.012350Z] Running download-and-extract step. 03:39:40 INFO - Running pre-action listener: _resource_record_pre_action 03:39:40 INFO - Running main action method: download_and_extract 03:39:40 INFO - mkdir: /builds/slave/test/build/tests 03:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:40 INFO - trying https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.test_packages.json 03:39:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:39:40 INFO - Downloaded 989 bytes. 03:39:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:39:40 INFO - Using the following test package requirements: 03:39:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:39:40 INFO - u'common': [u'target.common.tests.zip'], 03:39:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:39:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:39:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:39:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:39:40 INFO - u'mozbase': [u'target.common.tests.zip'], 03:39:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:39:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:39:40 INFO - u'web-platform': [u'target.common.tests.zip', 03:39:40 INFO - u'target.web-platform.tests.tar.gz'], 03:39:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:39:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:39:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.common.tests.zip 03:39:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:39:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.common.tests.zip into memory 03:39:41 INFO - Content-Length response header: 54946073 03:39:41 INFO - Bytes received: 54946073 03:39:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.talos.tests.zip 03:39:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:39:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.talos.tests.zip into memory 03:39:53 INFO - Content-Length response header: 14513823 03:39:53 INFO - Bytes received: 14513823 03:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:53 INFO - trying https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2 03:39:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:39:54 INFO - Downloaded 61730604 bytes. 03:39:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2 03:39:55 INFO - mkdir: /builds/slave/test/properties 03:39:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:55 INFO - Contents: 03:39:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2 03:39:55 INFO - Running post-action listener: _resource_record_post_action 03:39:55 INFO - Running post-action listener: find_tests_for_verification 03:39:55 INFO - Running post-action listener: set_extra_try_arguments 03:39:55 INFO - [mozharness: 2017-09-27 10:39:55.044259Z] Finished download-and-extract step (success) 03:39:55 INFO - [mozharness: 2017-09-27 10:39:55.044376Z] Running populate-webroot step. 03:39:55 INFO - Running pre-action listener: _resource_record_pre_action 03:39:55 INFO - Running main action method: populate_webroot 03:39:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:55 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['tresize', 03:39:55 INFO - 'tcanvasmark']}, 03:39:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:55 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['dromaeo_css', 03:39:55 INFO - 'kraken']}, 03:39:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:55 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'tests': ['damp', 'tps']}, 03:39:55 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['damp', 'tps']}, 03:39:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:55 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['dromaeo_dom']}, 03:39:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:39:55 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['basic_compositor_video', 03:39:55 INFO - 'glvideo']}, 03:39:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:39:55 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['ts_paint_webext', 03:39:55 INFO - 'tp5o_webext']}, 03:39:55 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:55 INFO - 'ts_paint', 03:39:55 INFO - 'tpaint', 03:39:55 INFO - 'sessionrestore', 03:39:55 INFO - 'sessionrestore_many_windows', 03:39:55 INFO - 'sessionrestore_no_auto_restore', 03:39:55 INFO - 'tabpaint']}, 03:39:55 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['a11yr', 03:39:55 INFO - 'ts_paint', 03:39:55 INFO - 'tpaint', 03:39:55 INFO - 'sessionrestore', 03:39:55 INFO - 'sessionrestore_many_windows', 03:39:55 INFO - 'sessionrestore_no_auto_restore', 03:39:55 INFO - 'tabpaint']}, 03:39:55 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:39:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:39:55 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['perf_reftest_singletons']}, 03:39:55 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['perf_reftest']}, 03:39:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:55 INFO - 'tsvgr_opacity', 03:39:55 INFO - 'tart', 03:39:55 INFO - 'tscrollx', 03:39:55 INFO - 'tsvg_static']}, 03:39:55 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['tsvgx', 03:39:55 INFO - 'tsvgr_opacity', 03:39:55 INFO - 'tart', 03:39:55 INFO - 'tscrollx', 03:39:55 INFO - 'tsvg_static']}, 03:39:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:39:55 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'talos_options': ['--disable-stylo'], 03:39:55 INFO - 'tests': ['tp5o']}, 03:39:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:39:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:39:55 INFO - 'talos_options': ['--mitmproxy', 03:39:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:39:55 INFO - '--firstNonBlankPaint'], 03:39:55 INFO - 'tests': ['tp6_google', 03:39:55 INFO - 'tp6_youtube', 03:39:55 INFO - 'tp6_amazon', 03:39:55 INFO - 'tp6_facebook']}, 03:39:55 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:39:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:39:55 INFO - 'talos_options': ['--disable-stylo', 03:39:55 INFO - '--mitmproxy', 03:39:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:39:55 INFO - '--firstNonBlankPaint'], 03:39:55 INFO - 'tests': ['tp6_google', 03:39:55 INFO - 'tp6_youtube', 03:39:55 INFO - 'tp6_amazon', 03:39:55 INFO - 'tp6_facebook']}, 03:39:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:39:55 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:39:55 INFO - 'talos_options': ['--stylo-threads=1', 03:39:55 INFO - '--mitmproxy', 03:39:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:39:55 INFO - '--firstNonBlankPaint'], 03:39:55 INFO - 'tests': ['tp6_google', 03:39:55 INFO - 'tp6_youtube', 03:39:55 INFO - 'tp6_amazon', 03:39:55 INFO - 'tp6_facebook']}, 03:39:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'talos_options': ['--xperf_path', 03:39:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:55 INFO - 'tests': ['tp5n']}, 03:39:55 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:39:55 INFO - 'talos_options': ['--disable-stylo', 03:39:55 INFO - '--xperf_path', 03:39:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:55 INFO - 'tests': ['tp5n']}}} 03:39:55 INFO - Running post-action listener: _resource_record_post_action 03:39:55 INFO - [mozharness: 2017-09-27 10:39:55.063265Z] Finished populate-webroot step (success) 03:39:55 INFO - [mozharness: 2017-09-27 10:39:55.063354Z] Running create-virtualenv step. 03:39:55 INFO - Running pre-action listener: _resource_record_pre_action 03:39:55 INFO - Running main action method: create_virtualenv 03:39:55 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:39:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:39:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:39:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:55 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:55 INFO - Installing pip...............done. 03:39:55 INFO - Return code: 0 03:39:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:39:56 INFO - Reading from file tmpfile_stdout 03:39:56 INFO - Output received: 03:39:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:39:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:56 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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:39:56 INFO - Using env: {'DISPLAY': ':0', 03:39:56 INFO - 'HOME': '/home/cltbld', 03:39:56 INFO - 'LANG': 'en_US.UTF-8', 03:39:56 INFO - 'LANGUAGE': 'en_US:en', 03:39:56 INFO - 'LOGNAME': 'cltbld', 03:39:56 INFO - 'MAIL': '/var/mail/cltbld', 03:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:56 INFO - 'MOZ_NO_REMOTE': '1', 03:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:56 INFO - 'NO_EM_RESTART': '1', 03:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:56 INFO - 'PWD': '/builds/slave/test', 03:39:56 INFO - 'SHELL': '/bin/bash', 03:39:56 INFO - 'SHLVL': '1', 03:39:56 INFO - 'TERM': 'linux', 03:39:56 INFO - 'TMOUT': '86400', 03:39:56 INFO - 'USER': 'cltbld', 03:39:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:56 INFO - '_': '/tools/buildbot/bin/python'} 03:39:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:39:57 INFO - Downloading/unpacking pip>=1.5 03:39:57 INFO - Running setup.py egg_info for package pip 03:39:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:39:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:39:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:39:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:39:57 INFO - Installing collected packages: pip 03:39:57 INFO - Found existing installation: pip 1.1 03:39:57 INFO - Uninstalling pip: 03:39:57 INFO - Successfully uninstalled pip 03:39:57 INFO - Running setup.py install for pip 03:39:57 INFO - warning: no files found matching 'pip/cacert.pem' 03:39:57 INFO - warning: no files found matching '*.html' under directory 'docs' 03:39:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:39:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:39:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:39:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:39:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:39:57 INFO - Successfully installed pip 03:39:57 INFO - Cleaning up... 03:39:57 INFO - Return code: 0 03:39:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:57 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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:39:57 INFO - Using env: {'DISPLAY': ':0', 03:39:57 INFO - 'HOME': '/home/cltbld', 03:39:57 INFO - 'LANG': 'en_US.UTF-8', 03:39:57 INFO - 'LANGUAGE': 'en_US:en', 03:39:57 INFO - 'LOGNAME': 'cltbld', 03:39:57 INFO - 'MAIL': '/var/mail/cltbld', 03:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:57 INFO - 'MOZ_NO_REMOTE': '1', 03:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:57 INFO - 'NO_EM_RESTART': '1', 03:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:57 INFO - 'PWD': '/builds/slave/test', 03:39:57 INFO - 'SHELL': '/bin/bash', 03:39:57 INFO - 'SHLVL': '1', 03:39:57 INFO - 'TERM': 'linux', 03:39:57 INFO - 'TMOUT': '86400', 03:39:57 INFO - 'USER': 'cltbld', 03:39:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:57 INFO - '_': '/tools/buildbot/bin/python'} 03:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:57 INFO - Downloading/unpacking psutil>=3.1.1 03:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:58 INFO - Installing collected packages: psutil 03:39:58 INFO - Running setup.py install for psutil 03:39:58 INFO - building 'psutil._psutil_linux' extension 03:39:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:39:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:39:59 INFO - building 'psutil._psutil_posix' extension 03:39:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:39:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:39:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:59 INFO - Successfully installed psutil 03:39:59 INFO - Cleaning up... 03:39:59 INFO - Return code: 0 03:39:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39: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')]} 03:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:39: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 mozsystemmonitor==0.3 03:39:59 INFO - Using env: {'DISPLAY': ':0', 03:39:59 INFO - 'HOME': '/home/cltbld', 03:39:59 INFO - 'LANG': 'en_US.UTF-8', 03:39:59 INFO - 'LANGUAGE': 'en_US:en', 03:39:59 INFO - 'LOGNAME': 'cltbld', 03:39:59 INFO - 'MAIL': '/var/mail/cltbld', 03:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:59 INFO - 'MOZ_NO_REMOTE': '1', 03:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:39:59 INFO - 'NO_EM_RESTART': '1', 03:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:59 INFO - 'PWD': '/builds/slave/test', 03:39:59 INFO - 'SHELL': '/bin/bash', 03:39:59 INFO - 'SHLVL': '1', 03:39:59 INFO - 'TERM': 'linux', 03:39:59 INFO - 'TMOUT': '86400', 03:39:59 INFO - 'USER': 'cltbld', 03:39:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:59 INFO - '_': '/tools/buildbot/bin/python'} 03:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39: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 03:39: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 03:39: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 03:39: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 03:40:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:00 INFO - Installing collected packages: mozsystemmonitor 03:40:00 INFO - Running setup.py install for mozsystemmonitor 03:40:01 INFO - Successfully installed mozsystemmonitor 03:40:01 INFO - Cleaning up... 03:40:01 INFO - Return code: 0 03:40:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40: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')]} 03:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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', '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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:40: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 jsonschema==2.5.1 03:40:01 INFO - Using env: {'DISPLAY': ':0', 03:40:01 INFO - 'HOME': '/home/cltbld', 03:40:01 INFO - 'LANG': 'en_US.UTF-8', 03:40:01 INFO - 'LANGUAGE': 'en_US:en', 03:40:01 INFO - 'LOGNAME': 'cltbld', 03:40:01 INFO - 'MAIL': '/var/mail/cltbld', 03:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:01 INFO - 'MOZ_NO_REMOTE': '1', 03:40:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:01 INFO - 'NO_EM_RESTART': '1', 03:40:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:01 INFO - 'PWD': '/builds/slave/test', 03:40:01 INFO - 'SHELL': '/bin/bash', 03:40:01 INFO - 'SHLVL': '1', 03:40:01 INFO - 'TERM': 'linux', 03:40:01 INFO - 'TMOUT': '86400', 03:40:01 INFO - 'USER': 'cltbld', 03:40:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:01 INFO - '_': '/tools/buildbot/bin/python'} 03:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:40: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 03:40: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 03:40: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 03:40: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 03:40:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40: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 03:40: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 03:40: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 03:40: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 03:40:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:03 INFO - warning: no files found matching '*.txt' 03:40:03 INFO - no previously-included directories found matching 'build' 03:40:03 INFO - no previously-included directories found matching 'dist' 03:40:03 INFO - no previously-included directories found matching '.git*' 03:40:03 INFO - Installing collected packages: jsonschema, functools32 03:40:04 INFO - Running setup.py install for functools32 03:40:04 INFO - warning: no files found matching '*.txt' 03:40:04 INFO - no previously-included directories found matching 'build' 03:40:04 INFO - no previously-included directories found matching 'dist' 03:40:04 INFO - no previously-included directories found matching '.git*' 03:40:04 INFO - Successfully installed jsonschema functools32 03:40:04 INFO - Cleaning up... 03:40:04 INFO - Return code: 0 03:40:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40: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')]} 03:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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 03:40: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 03:40:04 INFO - Using env: {'DISPLAY': ':0', 03:40:04 INFO - 'HOME': '/home/cltbld', 03:40:04 INFO - 'LANG': 'en_US.UTF-8', 03:40:04 INFO - 'LANGUAGE': 'en_US:en', 03:40:04 INFO - 'LOGNAME': 'cltbld', 03:40:04 INFO - 'MAIL': '/var/mail/cltbld', 03:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:04 INFO - 'MOZ_NO_REMOTE': '1', 03:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:04 INFO - 'NO_EM_RESTART': '1', 03:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:04 INFO - 'PWD': '/builds/slave/test', 03:40:04 INFO - 'SHELL': '/bin/bash', 03:40:04 INFO - 'SHLVL': '1', 03:40:04 INFO - 'TERM': 'linux', 03:40:04 INFO - 'TMOUT': '86400', 03:40:04 INFO - 'USER': 'cltbld', 03:40:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:04 INFO - '_': '/tools/buildbot/bin/python'} 03:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:04 INFO - Cleaning up... 03:40:04 INFO - Return code: 0 03:40:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40: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')]} 03:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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', '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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:40: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 blobuploader==1.2.4 03:40:04 INFO - Using env: {'DISPLAY': ':0', 03:40:04 INFO - 'HOME': '/home/cltbld', 03:40:04 INFO - 'LANG': 'en_US.UTF-8', 03:40:04 INFO - 'LANGUAGE': 'en_US:en', 03:40:04 INFO - 'LOGNAME': 'cltbld', 03:40:04 INFO - 'MAIL': '/var/mail/cltbld', 03:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:04 INFO - 'MOZ_NO_REMOTE': '1', 03:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:04 INFO - 'NO_EM_RESTART': '1', 03:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:04 INFO - 'PWD': '/builds/slave/test', 03:40:04 INFO - 'SHELL': '/bin/bash', 03:40:04 INFO - 'SHLVL': '1', 03:40:04 INFO - 'TERM': 'linux', 03:40:04 INFO - 'TMOUT': '86400', 03:40:04 INFO - 'USER': 'cltbld', 03:40:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:04 INFO - '_': '/tools/buildbot/bin/python'} 03:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:05 INFO - Downloading/unpacking blobuploader==1.2.4 03:40: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 03:40: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 03:40: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 03:40: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 03:40:06 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40:06 INFO - Downloading docopt-0.6.1.tar.gz 03:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:06 INFO - Running setup.py install for blobuploader 03:40:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:06 INFO - Running setup.py install for requests 03:40:07 INFO - Running setup.py install for docopt 03:40:07 INFO - Successfully installed blobuploader requests docopt 03:40:07 INFO - Cleaning up... 03:40:07 INFO - Return code: 0 03:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40: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')]} 03:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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 03:40: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 03:40:07 INFO - Using env: {'DISPLAY': ':0', 03:40:07 INFO - 'HOME': '/home/cltbld', 03:40:07 INFO - 'LANG': 'en_US.UTF-8', 03:40:07 INFO - 'LANGUAGE': 'en_US:en', 03:40:07 INFO - 'LOGNAME': 'cltbld', 03:40:07 INFO - 'MAIL': '/var/mail/cltbld', 03:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:07 INFO - 'MOZ_NO_REMOTE': '1', 03:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:07 INFO - 'NO_EM_RESTART': '1', 03:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:07 INFO - 'PWD': '/builds/slave/test', 03:40:07 INFO - 'SHELL': '/bin/bash', 03:40:07 INFO - 'SHLVL': '1', 03:40:07 INFO - 'TERM': 'linux', 03:40:07 INFO - 'TMOUT': '86400', 03:40:07 INFO - 'USER': 'cltbld', 03:40:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:07 INFO - '_': '/tools/buildbot/bin/python'} 03:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:07 INFO - Running setup.py (path:/tmp/pip-0nRh5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:07 INFO - Running setup.py (path:/tmp/pip-4XnK_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:07 INFO - Running setup.py (path:/tmp/pip-10TO5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:07 INFO - Running setup.py (path:/tmp/pip-nv_CIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:07 INFO - Running setup.py (path:/tmp/pip-5k55Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:08 INFO - Running setup.py (path:/tmp/pip-bFUeXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:08 INFO - Running setup.py (path:/tmp/pip-ZnRnAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:08 INFO - Running setup.py (path:/tmp/pip-Ioc8kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:08 INFO - Running setup.py (path:/tmp/pip-kTmAUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:08 INFO - Running setup.py (path:/tmp/pip-JG6fYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:08 INFO - Running setup.py (path:/tmp/pip-ebZ7A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:08 INFO - Running setup.py (path:/tmp/pip-bYUb2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:08 INFO - Running setup.py (path:/tmp/pip-gxEoIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:08 INFO - Running setup.py (path:/tmp/pip-2pr9IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:08 INFO - Running setup.py (path:/tmp/pip-DReFO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:08 INFO - Running setup.py (path:/tmp/pip-7AYrfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:08 INFO - Running setup.py (path:/tmp/pip-YBD4kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:08 INFO - Running setup.py install for manifestparser 03:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:08 INFO - Running setup.py install for mozcrash 03:40:09 INFO - Running setup.py install for mozdebug 03:40:09 INFO - Running setup.py install for mozdevice 03:40:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for mozfile 03:40:09 INFO - Running setup.py install for mozhttpd 03:40:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for mozinfo 03:40:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for mozInstall 03:40:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for mozleak 03:40:09 INFO - Running setup.py install for mozlog 03:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for moznetwork 03:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for mozprocess 03:40:10 INFO - Running setup.py install for mozprofile 03:40:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Running setup.py install for mozrunner 03:40:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Running setup.py install for mozscreenshot 03:40:10 INFO - Running setup.py install for moztest 03:40:10 INFO - Running setup.py install for mozversion 03:40:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:10 INFO - Cleaning up... 03:40:10 INFO - Return code: 0 03:40:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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 03:40: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 03:40:10 INFO - Using env: {'DISPLAY': ':0', 03:40:10 INFO - 'HOME': '/home/cltbld', 03:40:10 INFO - 'LANG': 'en_US.UTF-8', 03:40:10 INFO - 'LANGUAGE': 'en_US:en', 03:40:10 INFO - 'LOGNAME': 'cltbld', 03:40:10 INFO - 'MAIL': '/var/mail/cltbld', 03:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:10 INFO - 'MOZ_NO_REMOTE': '1', 03:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:10 INFO - 'NO_EM_RESTART': '1', 03:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:10 INFO - 'PWD': '/builds/slave/test', 03:40:10 INFO - 'SHELL': '/bin/bash', 03:40:10 INFO - 'SHLVL': '1', 03:40:10 INFO - 'TERM': 'linux', 03:40:10 INFO - 'TMOUT': '86400', 03:40:10 INFO - 'USER': 'cltbld', 03:40:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:10 INFO - '_': '/tools/buildbot/bin/python'} 03:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:10 INFO - Running setup.py (path:/tmp/pip-cI1fQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:10 INFO - Running setup.py (path:/tmp/pip-8IP6bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:10 INFO - Running setup.py (path:/tmp/pip-2zK0cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:11 INFO - Running setup.py (path:/tmp/pip-GzBX5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:11 INFO - Running setup.py (path:/tmp/pip-7yUmTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:11 INFO - Running setup.py (path:/tmp/pip-tLVRyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:11 INFO - Running setup.py (path:/tmp/pip-T8AgiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:11 INFO - Running setup.py (path:/tmp/pip-lz3ehz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:11 INFO - Running setup.py (path:/tmp/pip-3Jnulw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:11 INFO - Running setup.py (path:/tmp/pip-9AYh5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:11 INFO - Running setup.py (path:/tmp/pip-x6HyGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:11 INFO - Running setup.py (path:/tmp/pip-CLQEVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:11 INFO - Running setup.py (path:/tmp/pip-UHc3LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:11 INFO - Running setup.py (path:/tmp/pip-xBD9Ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40: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)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:11 INFO - Running setup.py (path:/tmp/pip-rJJU0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:11 INFO - Running setup.py (path:/tmp/pip-XMdh48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:11 INFO - Running setup.py (path:/tmp/pip-JG23wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40: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 03:40: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 03:40: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 03:40: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 03:40:13 INFO - Downloading blessings-1.6.tar.gz 03:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:13 INFO - Installing collected packages: blessings 03:40:13 INFO - Running setup.py install for blessings 03:40:13 INFO - Successfully installed blessings 03:40:13 INFO - Cleaning up... 03:40:13 INFO - Return code: 0 03:40:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:13 INFO - Reading from file tmpfile_stdout 03:40:13 INFO - Current package versions: 03:40:13 INFO - argparse == 1.2.1 03:40:13 INFO - blessings == 1.6 03:40:13 INFO - blobuploader == 1.2.4 03:40:13 INFO - docopt == 0.6.1 03:40:13 INFO - functools32 == 3.2.3-2 03:40:13 INFO - jsonschema == 2.5.1 03:40:13 INFO - manifestparser == 1.1 03:40:13 INFO - mozInstall == 1.13 03:40:13 INFO - mozcrash == 1.0 03:40:13 INFO - mozdebug == 0.1 03:40:13 INFO - mozdevice == 0.51 03:40:13 INFO - mozfile == 1.2 03:40:13 INFO - mozhttpd == 0.7 03:40:13 INFO - mozinfo == 0.10 03:40:13 INFO - mozleak == 0.1 03:40:13 INFO - mozlog == 3.5 03:40:13 INFO - moznetwork == 0.27 03:40:13 INFO - mozprocess == 0.25 03:40:13 INFO - mozprofile == 0.28 03:40:13 INFO - mozrunner == 6.13 03:40:13 INFO - mozscreenshot == 0.1 03:40:13 INFO - mozsystemmonitor == 0.3 03:40:13 INFO - moztest == 0.8 03:40:13 INFO - mozversion == 1.4 03:40:13 INFO - psutil == 3.1.1 03:40:13 INFO - requests == 1.2.3 03:40:13 INFO - wsgiref == 0.1.2 03:40:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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 03:40: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 03:40:13 INFO - Using env: {'DISPLAY': ':0', 03:40:13 INFO - 'HOME': '/home/cltbld', 03:40:13 INFO - 'LANG': 'en_US.UTF-8', 03:40:13 INFO - 'LANGUAGE': 'en_US:en', 03:40:13 INFO - 'LOGNAME': 'cltbld', 03:40:13 INFO - 'MAIL': '/var/mail/cltbld', 03:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:13 INFO - 'MOZ_NO_REMOTE': '1', 03:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:13 INFO - 'NO_EM_RESTART': '1', 03:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:13 INFO - 'PWD': '/builds/slave/test', 03:40:13 INFO - 'SHELL': '/bin/bash', 03:40:13 INFO - 'SHLVL': '1', 03:40:13 INFO - 'TERM': 'linux', 03:40:13 INFO - 'TMOUT': '86400', 03:40:13 INFO - 'USER': 'cltbld', 03:40:13 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:13 INFO - '_': '/tools/buildbot/bin/python'} 03:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:40: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 03:40: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 03:40: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 03:40: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 03:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:40:14 INFO - Installing collected packages: simplejson 03:40:14 INFO - Running setup.py install for simplejson 03:40:15 INFO - building 'simplejson._speedups' extension 03:40: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 03:40:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:40:15 INFO - Successfully installed simplejson 03:40:15 INFO - Cleaning up... 03:40:16 INFO - Return code: 0 03:40:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40: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')]} 03:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40: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 0x28e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c4d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, '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': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:40: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 03:40: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 03:40:16 INFO - Using env: {'DISPLAY': ':0', 03:40:16 INFO - 'HOME': '/home/cltbld', 03:40:16 INFO - 'LANG': 'en_US.UTF-8', 03:40:16 INFO - 'LANGUAGE': 'en_US:en', 03:40:16 INFO - 'LOGNAME': 'cltbld', 03:40:16 INFO - 'MAIL': '/var/mail/cltbld', 03:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:16 INFO - 'MOZ_NO_REMOTE': '1', 03:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:16 INFO - 'NO_EM_RESTART': '1', 03:40:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:16 INFO - 'PWD': '/builds/slave/test', 03:40:16 INFO - 'SHELL': '/bin/bash', 03:40:16 INFO - 'SHLVL': '1', 03:40:16 INFO - 'TERM': 'linux', 03:40:16 INFO - 'TMOUT': '86400', 03:40:16 INFO - 'USER': 'cltbld', 03:40:16 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:16 INFO - '_': '/tools/buildbot/bin/python'} 03:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:16 INFO - Cleaning up... 03:40:16 INFO - Return code: 0 03:40:16 INFO - Running post-action listener: _resource_record_post_action 03:40:16 INFO - Running post-action listener: _start_resource_monitoring 03:40:16 INFO - Starting resource monitoring. 03:40:16 INFO - [mozharness: 2017-09-27 10:40:16.286357Z] Finished create-virtualenv step (success) 03:40:16 INFO - [mozharness: 2017-09-27 10:40:16.286881Z] Running install step. 03:40:16 INFO - Running pre-action listener: _resource_record_pre_action 03:40:16 INFO - Running main action method: install 03:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:16 INFO - Reading from file tmpfile_stdout 03:40:16 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:16 INFO - Reading from file tmpfile_stdout 03:40:16 INFO - Output received: 03:40:16 INFO - Usage: mozinstall [options] installer 03:40:16 INFO - Options: 03:40:16 INFO - -h, --help show this help message and exit 03:40:16 INFO - -d DEST, --destination=DEST 03:40:16 INFO - Directory to install application into. [default: 03:40:16 INFO - "/builds/slave/test"] 03:40:16 INFO - --app=APP Application being installed. [default: firefox] 03:40:16 INFO - mkdir: /builds/slave/test/build/application 03:40: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'] 03:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:40:34 INFO - Reading from file tmpfile_stdout 03:40:34 INFO - Output received: 03:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 03:40:34 INFO - Running post-action listener: _resource_record_post_action 03:40:34 INFO - [mozharness: 2017-09-27 10:40:34.479033Z] Finished install step (success) 03:40:34 INFO - [mozharness: 2017-09-27 10:40:34.479287Z] Running setup-mitmproxy step. 03:40:34 INFO - Running pre-action listener: _resource_record_pre_action 03:40:34 INFO - Running main action method: setup_mitmproxy 03:40:34 INFO - Skipping: mitmproxy is not required 03:40:34 INFO - Running post-action listener: _resource_record_post_action 03:40:34 INFO - [mozharness: 2017-09-27 10:40:34.480419Z] Finished setup-mitmproxy step (success) 03:40:34 INFO - [mozharness: 2017-09-27 10:40:34.480639Z] Running run-tests step. 03:40:34 INFO - Running pre-action listener: _resource_record_pre_action 03:40:34 INFO - Running pre-action listener: _set_gcov_prefix 03:40:34 INFO - Running main action method: run_tests 03:40:34 WARNING - Try message not found. 03:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:34 INFO - Python 2.7.3 03:40:34 INFO - Return code: 0 03:40:34 INFO - grabbing minidump binary from tooltool 03:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:34 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 0x2c4ad60>, '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 0x2c4ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c4bef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:40:34 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:40:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:34 INFO - Return code: 0 03:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:34 INFO - ENV: RUST_BACKTRACE is now full 03:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:40:34 INFO - Using env: {'DISPLAY': ':0', 03:40:34 INFO - 'HOME': '/home/cltbld', 03:40:34 INFO - 'LANG': 'en_US.UTF-8', 03:40:34 INFO - 'LANGUAGE': 'en_US:en', 03:40:34 INFO - 'LOGNAME': 'cltbld', 03:40:34 INFO - 'MAIL': '/var/mail/cltbld', 03:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:34 INFO - 'MOZ_NO_REMOTE': '1', 03:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:34 INFO - 'NO_EM_RESTART': '1', 03:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:34 INFO - 'PWD': '/builds/slave/test', 03:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:34 INFO - 'RUST_BACKTRACE': 'full', 03:40:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:40:34 INFO - 'SHELL': '/bin/bash', 03:40:34 INFO - 'SHLVL': '1', 03:40:34 INFO - 'TERM': 'linux', 03:40:34 INFO - 'TMOUT': '86400', 03:40:34 INFO - 'USER': 'cltbld', 03:40:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:34 INFO - '_': '/tools/buildbot/bin/python'} 03:40:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:40:34 INFO - mozversion application_buildid: 20170927094612 03:40:34 INFO - mozversion application_changeset: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 03:40:34 INFO - mozversion application_display_name: Nightly 03:40:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:34 INFO - mozversion application_name: Firefox 03:40:34 INFO - mozversion application_remotingname: firefox 03:40:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:40:34 INFO - mozversion application_vendor: Mozilla 03:40:34 INFO - mozversion application_version: 58.0a1 03:40:34 INFO - mozversion platform_buildid: 20170927094612 03:40:34 INFO - mozversion platform_changeset: 5563e7da39b265ed1ba7796ec058bdbcf6f792f6 03:40:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:40:34 INFO - mozversion platform_version: 58.0a1 03:40:34 INFO - using testdate: 1506508834 03:40:34 INFO - actual date: 1506508834 03:40:34 INFO - starting webserver on 'localhost:51998' 03:40:34 INFO - SUITE-START | Running 2 tests 03:40:34 INFO - TEST-START | dromaeo_css 03:40:34 INFO - Initialising browser for dromaeo_css test... 03:40:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51998/getInfo.html -profile /tmp/tmpvenEvC/profile 03:40:34 INFO - TEST-INFO | started process 27963 (/builds/slave/test/build/application/firefox/firefox http://localhost:51998/getInfo.html) 03:40:39 INFO - TEST-INFO | 27963: exit 0 03:40:40 INFO - Browser initialized. 03:40:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:40 INFO - Using env: {'DISPLAY': ':0', 03:40:40 INFO - 'HOME': '/home/cltbld', 03:40:40 INFO - 'JSGC_DISABLE_POISONING': '1', 03:40:40 INFO - 'LANG': 'en_US.UTF-8', 03:40:40 INFO - 'LANGUAGE': 'en_US:en', 03:40:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:40:40 INFO - 'LOGNAME': 'cltbld', 03:40:40 INFO - 'MAIL': '/var/mail/cltbld', 03:40:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:40:40 INFO - 'MOZ_CRASHREPORTER': '1', 03:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:40:40 INFO - 'MOZ_NO_REMOTE': '1', 03:40:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:40 INFO - 'NO_EM_RESTART': '1', 03:40:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:40 INFO - 'PWD': '/builds/slave/test', 03:40:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:40 INFO - 'RUST_BACKTRACE': 'full', 03:40:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:40:40 INFO - 'SHELL': '/bin/bash', 03:40:40 INFO - 'SHLVL': '1', 03:40:40 INFO - 'TERM': 'linux', 03:40:40 INFO - 'TMOUT': '86400', 03:40:40 INFO - 'USER': 'cltbld', 03:40:40 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:40 INFO - '_': '/tools/buildbot/bin/python'} 03:40:40 INFO - TEST-INFO | started process 28195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvenEvC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:41 INFO - PID 28195 | 03:40:41 INFO - PID 28195 | (/builds/slave/test/build/application/firefox/firefox:28244): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:40:41 INFO - PID 28195 | 03:40:51 INFO - PID 28195 | RSS: Main: 153300992 03:40:51 INFO - PID 28195 | 03:43:47 INFO - PID 28195 | Cycle 1(1): loaded http://localhost:51998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51998/tests/dromaeo/cssquery-ext.html) 03:43:48 INFO - PID 28195 | RSS: Main: 153821184 03:43:48 INFO - PID 28195 | 03:46:50 INFO - PID 28195 | Cycle 1(1): loaded http://localhost:51998/tests/dromaeo/cssquery-ext.html (next: http://localhost:51998/tests/dromaeo/cssquery-jquery.html) 03:46:51 INFO - PID 28195 | RSS: Main: 153686016 03:46:51 INFO - PID 28195 | 03:49:53 INFO - PID 28195 | Cycle 1(1): loaded http://localhost:51998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51998/tests/dromaeo/cssquery-mootools.html) 03:49:53 INFO - PID 28195 | RSS: Main: 155426816 03:49:53 INFO - PID 28195 | 03:52:55 INFO - PID 28195 | Cycle 1(1): loaded http://localhost:51998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51998/tests/dromaeo/cssquery-prototype.html) 03:52:55 INFO - PID 28195 | RSS: Main: 154259456 03:52:55 INFO - PID 28195 | 03:55:59 INFO - PID 28195 | Cycle 1(1): loaded http://localhost:51998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51998/tests/dromaeo/cssquery-yui.html) 03:55:59 INFO - PID 28195 | RSS: Main: 155140096 03:55:59 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | Cycle 1(1): loaded http://localhost:51998/tests/dromaeo/cssquery-yui.html (next: http://localhost:51998/tests/dromaeo/cssquery-dojo.html) 03:59:01 INFO - PID 28195 | RSS: Main: 157761536 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | __start_tp_report 03:59:01 INFO - PID 28195 | _x_x_mozilla_page_load 03:59:01 INFO - PID 28195 | _x_x_mozilla_page_load_details 03:59:01 INFO - PID 28195 | |i|pagename|runs| 03:59:01 INFO - PID 28195 | |0;dojo.html;3074.5849310343106;3078.815271083734;3111.766617503687;3112.7509799216064;3159.889403870865;6110.297315808683;6189.164462797521;6237.625742455456;6258.687065646716;6332.968335158329;6138.570300078996;6179.382061793818;6230.127782110497;6309.4636955858805;6329.810105696825;5811.738471768781;5822.534197264209;5862.530997520188;5884.882302353951;5924.763009479616;33.14590115418763;5663.5186009189265;5737.110747834093;5763.221965034709;5841.474267315941;5704.201411802351;5714.114312281561;5737.684427356494;5793.652380857162;5823.708814559276;5717.371089180187;5719.313682358102;5769.88460230793;5772.365039845614;5816.331121920991;5706.514946229576;5735.4551317624755;5767.567432442584;5773.393793651648;5807.738651760681;6146.354632763585;6247.781327653511;6295.118683384329;6307.432331090224;6309.3059763426445;6511.251206111263;6546.70539825709;6587.044878492639;6646;6651.501137414713;6672.566283191577;6701.061851340816;6792;6819.829504262383;6822.761203357908;6290.3709629037185;6315.989441689354;6320.968395158041;6322.4942004639515;6322.936770632326;6915.654217289216;6929.3070692931315;6938.375546200765;7011.579305241702;7038.049863268496;6392.616443013434;6543;6587.63767992765;6659.367360100783;6679.165104361955;6595.637239951849;6665.533412661067;6666.26671066192;6672.432843208382;6680.565763225375;6747.527673062838;6757.797266082025;6760.290169532227;6767.796966091025;6785.050092986986;6699.363560461748;6713.865722685617;6714.261431242559;6796.558223715443;6806.55757375769;5125.359330083739;5197.272381866542;5219.399769026534;5293.20601909709;5325.0148722486465;4601.7699115044115;4605.953940460619;4627.5603817637275;4666.136764698542;4674.345591617176;5655.406182350876;5741.971290143606;5754.079347304495;5759.452851979056;5767.480926716616;6647.235567909655;6648.069270302161;6682.699278532477;6743.831404214934;6744.83137921546;5576.1356989666665;5602.215689803349;5684.715764211773;5688.033034384164;5752.884942301214;5789.1605717171615;5797.623154494944;5805.709714514257;5812.186293918855;5813.82558523245;6268.153799237136;6394.680265986682;6403.48772098231;6419.807405777834;6420.165378500858;6471.805845824632;6657.700403481855;6689;6706.295838936841;6718.8320291993095;6419.2938776735455;6421.967890160519;6504.056911747864;6505;6557.836054098686;6462.063000864942;6539.705713243011;6545.642022188855;6639.535232533676;6650.3682150195655;6661.566998145105;6677.232118306457;6680.899786503303;6685.298043705536;6688.665566721742;6436.227652681709;6486.286508484157;6568.507361947777;6569.57297775643;6580.8354791130605;6459.095726598186;6523.869522609426;6563.310852360433;6568.540202185801;6578.967105164635;6374.840628984312;6392.712327945346;6451.41937225652;6459.967700161469;6477.4170324671;6422.871542569216;6458.741650333934;6463.935360646521;6513.967430162819;6527.477801775752;6207.34822843613;6392.584482008655;6405.743770249138;6415.326390729093;6421.935780642134 03:59:01 INFO - PID 28195 | |1;ext.html;850.2815121222565;875.4353442029891;901.7835719427335;903.6791938861704;908.1281969309458;40239;40963.79518102413;41422.792886035524;41472.792636036815;41512.79243603782;38106.618933810656;40587.188256234855;41386;41505;41697.7915110424;7911.960440197791;8042.276195142436;8045.678172873078;8045.718399856006;8075.273225409712;7914.129445760962;8011.639476223584;8034.196580341977;8036.27673509384;8037.477563958324;8047.51714897108;8055.234752698513;8057.194280571925;8058.798530036737;8077.7576672699915;8013.118556958759;8038.276555110039;8042.034955805282;8045.356371490267;8079.878801817978;7808.492447990862;7870.72452464161;7872.370210383213;7872.763817085496;7890.329322007637;38493.42259866104;38652.80673596642;38694.419583706265;38714;38737.03157421059;3543.2382037861985;3574.3566158091535;3586.1393265616066;3591.7306202034692;3602.2975519773654;31847.203819904455;31866.203344916332;31929.52105718416;31968;32004;4998.975005124988;5228.47715228478;5254.842354729364;5282.894342113136;5288.6826790392315;186992.06503967394;187412;187906;188278;188981.99999999863;46295.76852115785;46412.767936160104;46480;46526.534734652894;46599.76700116478;48973.51026489761;52688;53468;53479.73260133674;53546.46453535493;13726.382312795948;13809.240491772847;13819.170849749047;13860.653483662989;13882.375293111834;12198.268103913793;12421.130520863453;12428.067894907737;12433.254004759743;12433.875661243272;14163.929180354238;14316.355763990645;14383.208923509308;14386.712265754626;14473;5694.345150307685;5695.145728140812;5798.681072540966;5804.680742559115;5898.8230353089475;992.8659630949874;996.2876543271595;1000.8548760429696;1011.5751384418562;1024.538957469142;22531.43671408228;22822.65766013511;22945.655815162787;23221;23616.17343392973;1063.8776540697763;1093.2565855218368;1098.6813823990954;1099.587654629514;1100.1199040767515;12221.388930553438;12230;12307.507699691912;12444.81332780009;12484.500619975099;237855;238555;239278;239298;239927;43892.78053609712;45010.77494612506;51757.7412112937;52692;52976.73511632417;1414.533204042684;1420.872121509069;1430.8640679135465;1432.4771458417601;1436.346462359624;26670.466590668468;26678.333041674112;26888.32779180536;26903;27148.1855544334;36179;36223.818880905426;36450.27099458049;36523.26953460969;36694;191289;191349;192294;192370;192999;32368.514472283405;33503.162420938694;33948.151296216805;34245.82877085599;34276.48585271173;41250.38124428196;42908.570914291704;43119.56880431156;43189.352159718255;43504;31178.844105780234;31213.53179702261;31333.52999705052;31541.52687709732;31808;30256.243593910327;30802.845985770826;31219.687803121677;31641.8417907909;31938.52092218665;35151.29697406089;35182;35210;35265.647343527264;35463.468047978786;30687.386252274384;30695.539566906962;30738.385232295677;31241.218969525944;31656.208594785316;22700.318990430314;22935.541289174456;23037.308880733606;23138.884305578365;23416.180433684738 03:59:01 INFO - PID 28195 | |2;jquery.html;606.6936197220404;609.923759530059;613.895637741584;620.5656040771461;628.5034822490231;21898.89050554747;22585.887070564666;22656.546869062608;22670.206542771008;22671.20650777221;20445.284415045477;24213.878930605366;24350.512989740193;24380.75619243807;24432.511349772994;6400.871982560346;6585.275619681831;6592.406683398493;6594.4065034146915;6598.901016484757;6342.841428964267;6443.162388889461;6570.540062195648;6612.603243805363;6637.933620663804;6593.736250549972;6598.142241508621;6598.439132673729;6601.966990165042;6604.966975165142;6241.500679945593;6603.93396066038;6606.174228221473;6619.205695316568;6620.139381880349;6060.787872424444;6065.5450841187085;6080.513558915276;6082.422169893853;6085.330613632541;27948.301292467648;28376;28491.85754071237;28527.429451410855;28589.142325730263;2106.494441334084;2107.862988905716;2128.4146859613575;2135.5088329684104;2137.95724085519;18749.62500749991;19175.61648767017;19493.610127797507;19555.706664400044;19655.508612284666;2389.784919357266;2422.697162854643;2449.3876530867283;2457.213691618683;2464.051340234023;121557.39221303926;128134.35932820276;133521;140457.99999999898;140769;14599.15107311539;14628.853711462749;14685.527834546658;14731.558053258419;14744.909174477041;22843.543129137324;22982.42543936415;22986.42533936665;23134.305970820904;23165.189218377276;9451.574679139456;9495.335326527076;9519;9555.713328600154;9585.520723963775;8395.62219700115;8455.74632761018;8495.277901378453;8559.614817333235;8583.227509524173;8681.348898832613;8882.15619516145;8956.596953137125;8980.685676001309;9181.954090229507;2711.823731457449;2719.0619236363423;2740.287525243411;2756.503829310703;2822;958.3435346787472;965.5558443116105;981.0385821894583;984.8867380251363;989.4656885281867;18375.173117209757;18680.906595467208;18840.43478695641;18935.621287574173;19145.2341906325;1016.4714348538719;1022.6983040003217;1031.6286136990677;1035.2856528994969;1036.9222308326905;10075.395476271447;10252.794944101226;10289.43408112546;10335.844962325571;10640.042396184226;464697;472034;487393;489644;490855;108456.4577177109;113455;113550;114183;114516;1145.1869172887343;1152.4929031226234;1172.6364826903687;1173.6537721372215;1173.7065733566608;16955.745663814807;17002.064886431366;17129.571760706083;17306.913465432594;17504.82495175083;53804;54496.45503544914;54497.18254226111;55222;55456.72271638616;67055.66472167608;67168.6641566789;67200.32799672136;69493.65253173701;70094.29905700877;13659.180449173082;14190;14202;14216.644583885485;14224.857751422353;21519.569608608053;21916.12335506626;21999.890000550535;22077.889610552487;22147.889260553595;17591.472255832345;17928.462146135636;17955;17975.550611234823;17998.460046198634;15752.291146898646;15953.521394358188;16042.67914641724;16080.195990200209;16480.42318518846;17319.913400432917;17565.946043237447;18029.278828847226;18178.45464636063;18217.90891045589;13769.931150344584;13874.653133671336;14046.78929816033;14059.297035147996;14132;17072.57318567046;17238.138093095546;17277.56806079858;17415.56461088483;17453.30186792514 03:59:01 INFO - PID 28195 | |3;mootools.html;1316.7893137098067;1362.8500864904859;1372.512757970921;1383.59184040708;1394.9790753138698;15173.620659483518;15919;15950.601234969132;15978.680426391466;15988.600284992866;15740;15893.84106158938;15897.52307430776;15921.442749503769;15922.283497242623;2756.3660358117645;2762.9171124866234;2792.5531914893622;2792.860356982153;2804.2708895687065;2698.4198397344567;2728.4406696627243;2737.178846346098;2739.369944912671;2745.4646343962936;2637.525245455817;2744.698083210845;2756.1731480555854;2757.931051723713;2758.8344699318004;2720.9727902720915;2765.9308517287027;2783.7772978161697;2795.0915952315477;2798.0906205483197;2728.6589176352954;2762.309422644339;2766.432881259337;2774.5838124281518;2781.8887244510197;15044.473443429428;15330.770038449433;15381.538553843402;15383.538493845203;15387.615309617237;7841.607919604054;8073.990751156105;8080.313173380269;8117.431779775418;8118.431709780259;5152.4847515248175;5167.586593072545;5181.404138524081;5206.219067139959;5252.448492908266;1796.4790210838842;1828.1133650179652;1850.1211924335832;1877.8685492015563;1894.6400183965002;27981.860090699618;28084.157475275773;28143.718562814316;28287.85856070727;28305.15084547467;6787.389134977876;6864.141982252218;6899.827504312332;7002.089728335284;7042.894356584656;17937.820621793875;17949.7307540387;17974.1012949352;18053.187606557738;18175.09124543794;7945.920540794518;7970.840583188304;8019.719309824128;8058.274755272054;8061.153578874251;7260.947162661385;7365.484416090822;7442.957985881981;7451.366633836076;7497.737579184703;5184.714840683799;5336.973315133399;5372.7313634318125;5392.757325920343;5400.189971504227;1357.6402253402857;1407.9507217247346;1472.63184203949;1483.4437086092714;1506.5480355893187;790.8892755014302;867.8741582470507;921.3642586615214;926.1803304075942;934.5187228577288;7708.03649543807;7725.459217854808;7727.884081738666;7756.108047574488;7895.7236496722335;969.970900872975;973.2943615878431;981.5877331520778;983.7393090830935;987.09680642213;4672.6261899047995;4850.490698476679;4865.9756701216265;4872.731999739977;4897.877553061202;20613.896930515253;21926.45183870384;22202.111915523197;22497.775022249894;22501.662475062887;21807.67288490674;22079.227227046977;22220.555588888456;22250.109995599996;22352;11099.500522476508;11146.665600032013;11198.328100314007;11295.548178072784;11344.546218151347;8356.749297521084;8415.495070295801;8453.281471075028;8501.914980850359;8502.957485212535;18304.26782928668;18511.166997484877;18946;18951;19240.71138932945;18886.905565472083;18960.715589265896;19013.14440850193;19053.618927621646;19252.711209332152;11283.774324513299;11414;11417.31496110236;11491.942540287246;11526.654200374001;13984.790228146789;14061.156330620195;14095.506657266946;14106.576802695936;14135.15189088658;11645.243059201124;11672.70818229551;11889.28664280146;11996;12034.939825300817;11305.773884522428;11509.424528773361;11510.42447877586;11733.413329333669;11877.168598198388;10260.692179234635;10319.071283584513;10524.31591946521;10550.89449105499;10556;7299.379552738077;7495.962520187582;7542.962285188539;7583.9620801895635;7606.391488681003;7489.101307843093;7524.510906791041;7527.8118047049265;7617.200193979774;7716.305532502101 03:59:01 INFO - PID 28195 | |4;prototype.html;514.5831876180295;523.7302789063633;539.8731298144936;543.8694713268817;549.9092649712798;6077.787277445284;6164.81505554833;6182.196314479117;6235.906461403082;6293.4335909768115;6125.356837532062;6169.3830616938285;6171.81484555463;6238.719257633406;6242.406971337716;5163.941392014628;5203.68777873327;5206.895862082756;5224;5255.448177941318;4852.320675105488;5041.3194218780545;5044.82343117991;5057.848264552069;5082.415522214956;5010.173321401964;5029.924551131736;5038.395392552899;5052.368453943257;5079.314292570492;4994.775235114428;4998.60011199105;5014.6991180529285;5044.9747751261375;5070.594352451795;4558.339040839093;4569.177548041352;4578.153041687298;4588.105319462706;4621.237495813187;6071.241094863142;6178.135061091406;6207.4723648489935;6241.438270555672;6319.33646967071;5664;5689.630174038674;5704.857378565527;5753.654780713129;5774.884502309972;6443;6520.706568204442;6577.177852768404;6602.141721576212;6608.173978252718;4909.263610458424;4918.606511479109;4965.801367945278;4970.304157417964;4996.100701873661;6813.921753865069;6816.659167041628;6865.828354291183;6899.689513971884;6937.930620693829;5008.023435430056;5064.518870707277;5081.364829396325;5090.618203634668;5108.438071812097;5158.8968220636125;5176.094183517869;5181.740912954413;5217.373915130209;5227.712475813791;5732.197492351074;5736.1682556029145;5785.855353616109;5791.82624521265;5794.232759008542;6298.307186209513;6356.45970092538;6479.287278399373;6663.4669226461765;6699.229588597276;1748.7059575913731;1769;1781.3141940353057;1788.847947924415;1804.592417914029;1083.6044843632176;1217.5616777959926;1222.9938850305691;1227.656256248252;1241.4351470081272;5518.889622207534;5600.355959064678;5645.943540564542;5665.235193248941;5669.744861481243;6618.98836029615;6677.332266773284;6690;6778.627175505395;6786.389224969677;5635.380108188096;5657.094864821609;5660.179274005246;5683.2895888014;5725.8568535786935;3481.7388695847912;3519.9472007919903;3521.595016573127;3537.2748586539697;3620.7646502977223;6406.4554512866;6415.615063096229;6456.192975878015;6477.870442591122;6521.771737989243;6799.082123913208;6822.181338239344;6833.863322733518;6893.75871844483;6940.271271516418;6430.549861509649;6455.838604034937;6481.902771458432;6572.6056436613;6572.901406479003;6547.220529013752;6558.409743123142;6608.240052394036;6682.164729408824;6686.665666716742;6568.9014664781025;6616.603003819594;6627.966860165669;6635.535512514078;6664.266930637529;6537.215534135934;6561.376669216417;6562.310957349409;6563.803085907431;6566.6388348639375;4943.3573635427165;4968.608789538935;5020.774065167003;5034.244863270393;5034.270030845581;6754.5609535380045;6789.524733268624;6807.863842723217;6807.863842723217;6812.897806533005;6488.286288508355;6498.480121590356;6535.4444872184495;6595.340465953366;6600.636964966973;6555.639439830855;6561.245456772342;6563.901541476977;6580.341965803382;6583.485798266522;6442.420182183626;6450.838729031811;6465.741370345134;6473.126127972663;6487.772927947499;6237.844053898689;6541.934580654132;6578.8355291118105;6608.546119853624;6656.73373065072;6362.331955144643;6392.456641185366;6405.459277724828;6436.645984470899;6454.806355809145 03:59:01 INFO - PID 28195 | |5;yui.html;901.477143256911;906.2478143141198;916.340235030778;924.7318277699468;930.0885132570086;19279.228830846765;20300;20314.288999885008;20497.692534611957;20633.793662063374;19805;21719.193176989123;21821.345359639196;21977.780222197773;22160.002799874044;974.7514383832131;1001.3491230700031;1003.8945910679383;1003.9899601004006;1004.3823048824993;984.251968503935;988.0810845913297;994.1599348550463;995.2485873165786;1006.4716024087339;1053.5522402978704;1057.735566108473;1061.124572227915;1061.5753698520575;1061.7133373989057;1058.4919238765358;1061.0344586426315;1061.3366645846345;1061.920355973305;1064.9680509584687;774.6475353714046;775.6432041261027;775.9340456061242;777.6189667063098;779.9142094369615;19136.330228442075;20878.47803804902;21061.368158955254;21068.157273709032;21077.367678969655;21748.13007479699;22033.228836990627;22107.557848842935;22245.11019559216;22305.888470557704;16949;17304.567385815328;17379.73930391045;17451.650966980716;17506.037167955757;3779.9244015119543;3815.3704638734575;3817.1983883384523;3817.790021548814;3819.8472061117523;134069;136658;136873;139369;142686;17294.394696185573;17343.479695609152;17405.65188696219;17597.736033959245;17635.911820440815;31346.84326578398;31501.054968350985;31613.36773264522;31635.683643163735;31796.68203317937;8445.915540844635;8628.568571571523;8636.913630863737;8715;8740.694075707319;4001.359782434855;4165.625093741578;4175.770332631673;4191.015111448807;4196.99272174682;5470.56235501159;5518.061929471919;5560.4161563035295;5561.443855614487;5566.972165139148;988.1353815411514;1001.5643195210107;1002.3334482569155;1019.7399663086014;1021.4024795494719;667.2626747444004;679.9320067993161;690.0408432279136;693.7051753005054;698.333091897237;11125.388103654215;11586.553065198;11830.467628956545;12340.629781106582;12481.375931203404;675.9560628559226;688.6074937285699;695.0010703813031;706.156143408632;709.762229653072;5426.403095659474;5487.110880373741;5525.419830917776;5605.327360716658;5657.179708942181;118708.40645796715;121333.39333303277;123893.38053309676;125024.37487812685;126736;107814.46092769486;110074.44962775295;110165;111248.44375778231;112859.43570282261;98605.50697246612;99902.50048749709;100619;100737;102104.48947755214;10328.483575821328;10384.42885641297;10441.373517588969;10531.526081326512;10535.420551869414;45065.54934450614;45494.77252613716;45770.31344529901;46096.53903461056;46111.07777844492;57107.428925710214;57280;57338.42661573331;58132.4186758127;58740;15390.461333853262;15471.071735695894;15607.453739119077;15649.608759781097;15719.371225150866;16158.919205403898;16216.918915405347;16319;16389.918050409673;16408.09755463461;14488.203148826915;14645.780313295521;14782.334794934039;14807.777883331973;14823.481178158712;14891.106533608017;15277.77083343773;15311;15398.692026159639;15467.149306788235;15862.841371586597;15897;15912.363505459653;15921.761173582174;15977.8402215981;12020.459079341275;12120.393980300772;12255;12381.257124572554;12530.686732831753;11988;12035.879641203475;12239;12310.446029928853;12495.750084998432 03:59:01 INFO - PID 28195 | __end_tp_report 03:59:01 INFO - PID 28195 | __start_cc_report 03:59:01 INFO - PID 28195 | _x_x_mozilla_cycle_collect,283 03:59:01 INFO - PID 28195 | __end_cc_report 03:59:01 INFO - PID 28195 | __startTimestamp1506509941615__endTimestamp 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | ------- Summary: start ------- 03:59:01 INFO - PID 28195 | Number of tests: 6 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | [#0] dojo.html Cycles:165 Average:6115.31 Median:6403.49 stddev:877.91 (13.7%) stddev-sans-first:847.57 03:59:01 INFO - PID 28195 | Values: 3074.6 3078.8 3111.8 3112.8 3159.9 6110.3 6189.2 6237.6 6258.7 6333.0 6138.6 6179.4 6230.1 6309.5 6329.8 5811.7 5822.5 5862.5 5884.9 5924.8 33.1 5663.5 5737.1 5763.2 5841.5 5704.2 5714.1 5737.7 5793.7 5823.7 5717.4 5719.3 5769.9 5772.4 5816.3 5706.5 5735.5 5767.6 5773.4 5807.7 6146.4 6247.8 6295.1 6307.4 6309.3 6511.3 6546.7 6587.0 6646.0 6651.5 6672.6 6701.1 6792.0 6819.8 6822.8 6290.4 6316.0 6321.0 6322.5 6322.9 6915.7 6929.3 6938.4 7011.6 7038.0 6392.6 6543.0 6587.6 6659.4 6679.2 6595.6 6665.5 6666.3 6672.4 6680.6 6747.5 6757.8 6760.3 6767.8 6785.1 6699.4 6713.9 6714.3 6796.6 6806.6 5125.4 5197.3 5219.4 5293.2 5325.0 4601.8 4606.0 4627.6 4666.1 4674.3 5655.4 5742.0 5754.1 5759.5 5767.5 6647.2 6648.1 6682.7 6743.8 6744.8 5576.1 5602.2 5684.7 5688.0 5752.9 5789.2 5797.6 5805.7 5812.2 5813.8 6268.2 6394.7 6403.5 6419.8 6420.2 6471.8 6657.7 6689.0 6706.3 6718.8 6419.3 6422.0 6504.1 6505.0 6557.8 6462.1 6539.7 6545.6 6639.5 6650.4 6661.6 6677.2 6680.9 6685.3 6688.7 6436.2 6486.3 6568.5 6569.6 6580.8 6459.1 6523.9 6563.3 6568.5 6579.0 6374.8 6392.7 6451.4 6460.0 6477.4 6422.9 6458.7 6463.9 6514.0 6527.5 6207.3 6392.6 6405.7 6415.3 6421.9 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | [#1] ext.html Cycles:180 Average:37388.65 Median:35237.82 stddev:53779.10 (152.6%) stddev-sans-first:53859.98 03:59:01 INFO - PID 28195 | Values: 850.3 875.4 901.8 903.7 908.1 40239.0 40963.8 41422.8 41472.8 41512.8 38106.6 40587.2 41386.0 41505.0 41697.8 7912.0 8042.3 8045.7 8045.7 8075.3 7914.1 8011.6 8034.2 8036.3 8037.5 8047.5 8055.2 8057.2 8058.8 8077.8 8013.1 8038.3 8042.0 8045.4 8079.9 7808.5 7870.7 7872.4 7872.8 7890.3 38493.4 38652.8 38694.4 38714.0 38737.0 3543.2 3574.4 3586.1 3591.7 3602.3 31847.2 31866.2 31929.5 31968.0 32004.0 4999.0 5228.5 5254.8 5282.9 5288.7 186992.1 187412.0 187906.0 188278.0 188982.0 46295.8 46412.8 46480.0 46526.5 46599.8 48973.5 52688.0 53468.0 53479.7 53546.5 13726.4 13809.2 13819.2 13860.7 13882.4 12198.3 12421.1 12428.1 12433.3 12433.9 14163.9 14316.4 14383.2 14386.7 14473.0 5694.3 5695.1 5798.7 5804.7 5898.8 992.9 996.3 1000.9 1011.6 1024.5 22531.4 22822.7 22945.7 23221.0 23616.2 1063.9 1093.3 1098.7 1099.6 1100.1 12221.4 12230.0 12307.5 12444.8 12484.5 237855.0 238555.0 239278.0 239298.0 239927.0 43892.8 45010.8 51757.7 52692.0 52976.7 1414.5 1420.9 1430.9 1432.5 1436.3 26670.5 26678.3 26888.3 26903.0 27148.2 36179.0 36223.8 36450.3 36523.3 36694.0 191289.0 191349.0 192294.0 192370.0 192999.0 32368.5 33503.2 33948.2 34245.8 34276.5 41250.4 42908.6 43119.6 43189.4 43504.0 31178.8 31213.5 31333.5 31541.5 31808.0 30256.2 30802.8 31219.7 31641.8 31938.5 35151.3 35182.0 35210.0 35265.6 35463.5 30687.4 30695.5 30738.4 31241.2 31656.2 22700.3 22935.5 23037.3 23138.9 23416.2 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | [#2] jquery.html Cycles:180 Average:33798.92 Median:22757.37 stddev:80961.12 (355.8%) stddev-sans-first:81149.88 03:59:01 INFO - PID 28195 | Values: 606.7 609.9 613.9 620.6 628.5 21898.9 22585.9 22656.5 22670.2 22671.2 20445.3 24213.9 24350.5 24380.8 24432.5 6400.9 6585.3 6592.4 6594.4 6598.9 6342.8 6443.2 6570.5 6612.6 6637.9 6593.7 6598.1 6598.4 6602.0 6605.0 6241.5 6603.9 6606.2 6619.2 6620.1 6060.8 6065.5 6080.5 6082.4 6085.3 27948.3 28376.0 28491.9 28527.4 28589.1 2106.5 2107.9 2128.4 2135.5 2138.0 18749.6 19175.6 19493.6 19555.7 19655.5 2389.8 2422.7 2449.4 2457.2 2464.1 121557.4 128134.4 133521.0 140458.0 140769.0 14599.2 14628.9 14685.5 14731.6 14744.9 22843.5 22982.4 22986.4 23134.3 23165.2 9451.6 9495.3 9519.0 9555.7 9585.5 8395.6 8455.7 8495.3 8559.6 8583.2 8681.3 8882.2 8956.6 8980.7 9182.0 2711.8 2719.1 2740.3 2756.5 2822.0 958.3 965.6 981.0 984.9 989.5 18375.2 18680.9 18840.4 18935.6 19145.2 1016.5 1022.7 1031.6 1035.3 1036.9 10075.4 10252.8 10289.4 10335.8 10640.0 464697.0 472034.0 487393.0 489644.0 490855.0 108456.5 113455.0 113550.0 114183.0 114516.0 1145.2 1152.5 1172.6 1173.7 1173.7 16955.7 17002.1 17129.6 17306.9 17504.8 53804.0 54496.5 54497.2 55222.0 55456.7 67055.7 67168.7 67200.3 69493.7 70094.3 13659.2 14190.0 14202.0 14216.6 14224.9 21519.6 21916.1 21999.9 22077.9 22147.9 17591.5 17928.5 17955.0 17975.6 17998.5 15752.3 15953.5 16042.7 16080.2 16480.4 17319.9 17565.9 18029.3 18178.5 18217.9 13769.9 13874.7 14046.8 14059.3 14132.0 17072.6 17238.1 17277.6 17415.6 17453.3 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | [#3] mootools.html Cycles:180 Average:9528.08 Median:2738.27 stddev:6920.88 (252.7%) stddev-sans-first:6912.79 03:59:01 INFO - PID 28195 | Values: 1316.8 1362.9 1372.5 1383.6 1395.0 15173.6 15919.0 15950.6 15978.7 15988.6 15740.0 15893.8 15897.5 15921.4 15922.3 2756.4 2762.9 2792.6 2792.9 2804.3 2698.4 2728.4 2737.2 2739.4 2745.5 2637.5 2744.7 2756.2 2757.9 2758.8 2721.0 2765.9 2783.8 2795.1 2798.1 2728.7 2762.3 2766.4 2774.6 2781.9 15044.5 15330.8 15381.5 15383.5 15387.6 7841.6 8074.0 8080.3 8117.4 8118.4 5152.5 5167.6 5181.4 5206.2 5252.4 1796.5 1828.1 1850.1 1877.9 1894.6 27981.9 28084.2 28143.7 28287.9 28305.2 6787.4 6864.1 6899.8 7002.1 7042.9 17937.8 17949.7 17974.1 18053.2 18175.1 7945.9 7970.8 8019.7 8058.3 8061.2 7260.9 7365.5 7443.0 7451.4 7497.7 5184.7 5337.0 5372.7 5392.8 5400.2 1357.6 1408.0 1472.6 1483.4 1506.5 790.9 867.9 921.4 926.2 934.5 7708.0 7725.5 7727.9 7756.1 7895.7 970.0 973.3 981.6 983.7 987.1 4672.6 4850.5 4866.0 4872.7 4897.9 20613.9 21926.5 22202.1 22497.8 22501.7 21807.7 22079.2 22220.6 22250.1 22352.0 11099.5 11146.7 11198.3 11295.5 11344.5 8356.7 8415.5 8453.3 8501.9 8503.0 18304.3 18511.2 18946.0 18951.0 19240.7 18886.9 18960.7 19013.1 19053.6 19252.7 11283.8 11414.0 11417.3 11491.9 11526.7 13984.8 14061.2 14095.5 14106.6 14135.2 11645.2 11672.7 11889.3 11996.0 12034.9 11305.8 11509.4 11510.4 11733.4 11877.2 10260.7 10319.1 10524.3 10550.9 10556.0 7299.4 7496.0 7543.0 7584.0 7606.4 7489.1 7524.5 7527.8 7617.2 7716.3 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | [#4] prototype.html Cycles:180 Average:5529.10 Median:6174.97 stddev:1536.55 (24.9%) stddev-sans-first:1494.05 03:59:01 INFO - PID 28195 | Values: 514.6 523.7 539.9 543.9 549.9 6077.8 6164.8 6182.2 6235.9 6293.4 6125.4 6169.4 6171.8 6238.7 6242.4 5163.9 5203.7 5206.9 5224.0 5255.4 4852.3 5041.3 5044.8 5057.8 5082.4 5010.2 5029.9 5038.4 5052.4 5079.3 4994.8 4998.6 5014.7 5045.0 5070.6 4558.3 4569.2 4578.2 4588.1 4621.2 6071.2 6178.1 6207.5 6241.4 6319.3 5664.0 5689.6 5704.9 5753.7 5774.9 6443.0 6520.7 6577.2 6602.1 6608.2 4909.3 4918.6 4965.8 4970.3 4996.1 6813.9 6816.7 6865.8 6899.7 6937.9 5008.0 5064.5 5081.4 5090.6 5108.4 5158.9 5176.1 5181.7 5217.4 5227.7 5732.2 5736.2 5785.9 5791.8 5794.2 6298.3 6356.5 6479.3 6663.5 6699.2 1748.7 1769.0 1781.3 1788.8 1804.6 1083.6 1217.6 1223.0 1227.7 1241.4 5518.9 5600.4 5645.9 5665.2 5669.7 6619.0 6677.3 6690.0 6778.6 6786.4 5635.4 5657.1 5660.2 5683.3 5725.9 3481.7 3519.9 3521.6 3537.3 3620.8 6406.5 6415.6 6456.2 6477.9 6521.8 6799.1 6822.2 6833.9 6893.8 6940.3 6430.5 6455.8 6481.9 6572.6 6572.9 6547.2 6558.4 6608.2 6682.2 6686.7 6568.9 6616.6 6628.0 6635.5 6664.3 6537.2 6561.4 6562.3 6563.8 6566.6 4943.4 4968.6 5020.8 5034.2 5034.3 6754.6 6789.5 6807.9 6807.9 6812.9 6488.3 6498.5 6535.4 6595.3 6600.6 6555.6 6561.2 6563.9 6580.3 6583.5 6442.4 6450.8 6465.7 6473.1 6487.8 6237.8 6541.9 6578.8 6608.5 6656.7 6362.3 6392.5 6405.5 6436.6 6454.8 03:59:01 INFO - PID 28195 | 03:59:01 INFO - PID 28195 | [#5] yui.html Cycles:180 Average:24625.53 Median:17616.82 stddev:35610.04 (202.1%) stddev-sans-first:35665.38 03:59:01 INFO - PID 28195 | Values: 901.5 906.2 916.3 924.7 930.1 19279.2 20300.0 20314.3 20497.7 20633.8 19805.0 21719.2 21821.3 21977.8 22160.0 974.8 1001.3 1003.9 1004.0 1004.4 984.3 988.1 994.2 995.2 1006.5 1053.6 1057.7 1061.1 1061.6 1061.7 1058.5 1061.0 1061.3 1061.9 1065.0 774.6 775.6 775.9 777.6 779.9 19136.3 20878.5 21061.4 21068.2 21077.4 21748.1 22033.2 22107.6 22245.1 22305.9 16949.0 17304.6 17379.7 17451.7 17506.0 3779.9 3815.4 3817.2 3817.8 3819.8 134069.0 136658.0 136873.0 139369.0 142686.0 17294.4 17343.5 17405.7 17597.7 17635.9 31346.8 31501.1 31613.4 31635.7 31796.7 8445.9 8628.6 8636.9 8715.0 8740.7 4001.4 4165.6 4175.8 4191.0 4197.0 5470.6 5518.1 5560.4 5561.4 5567.0 988.1 1001.6 1002.3 1019.7 1021.4 667.3 679.9 690.0 693.7 698.3 11125.4 11586.6 11830.5 12340.6 12481.4 676.0 688.6 695.0 706.2 709.8 5426.4 5487.1 5525.4 5605.3 5657.2 118708.4 121333.4 123893.4 125024.4 126736.0 107814.5 110074.4 110165.0 111248.4 112859.4 98605.5 99902.5 100619.0 100737.0 102104.5 10328.5 10384.4 10441.4 10531.5 10535.4 45065.5 45494.8 45770.3 46096.5 46111.1 57107.4 57280.0 57338.4 58132.4 58740.0 15390.5 15471.1 15607.5 15649.6 15719.4 16158.9 16216.9 16319.0 16389.9 16408.1 14488.2 14645.8 14782.3 14807.8 14823.5 14891.1 15277.8 15311.0 15398.7 15467.1 15862.8 15897.0 15912.4 15921.8 15977.8 12020.5 12120.4 12255.0 12381.3 12530.7 11988.0 12035.9 12239.0 12310.4 12495.8 03:59:01 INFO - PID 28195 | -------- Summary: end -------- 03:59:01 INFO - PID 28195 | 03:59:02 INFO - TEST-INFO | 28195: exit 0 03:59:02 INFO - TEST-OK | dromaeo_css | took 1107436ms 03:59:02 INFO - TEST-START | kraken 03:59:02 INFO - Initialising browser for kraken test... 03:59:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51998/getInfo.html -profile /tmp/tmp_yW5lf/profile 03:59:02 INFO - TEST-INFO | started process 28568 (/builds/slave/test/build/application/firefox/firefox http://localhost:51998/getInfo.html) 03:59:07 INFO - TEST-INFO | 28568: exit 0 03:59:07 INFO - Browser initialized. 03:59:07 INFO - Running cycle 1/1 for kraken test... 03:59:07 INFO - Using env: {'DISPLAY': ':0', 03:59:07 INFO - 'HOME': '/home/cltbld', 03:59:07 INFO - 'JSGC_DISABLE_POISONING': '1', 03:59:07 INFO - 'LANG': 'en_US.UTF-8', 03:59:07 INFO - 'LANGUAGE': 'en_US:en', 03:59:07 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:59:07 INFO - 'LOGNAME': 'cltbld', 03:59:07 INFO - 'MAIL': '/var/mail/cltbld', 03:59:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:59:07 INFO - 'MOZ_CRASHREPORTER': '1', 03:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:07 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:59:07 INFO - 'MOZ_NO_REMOTE': '1', 03:59:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:07 INFO - 'NO_EM_RESTART': '1', 03:59:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:07 INFO - 'PWD': '/builds/slave/test', 03:59:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:07 INFO - 'RUST_BACKTRACE': 'full', 03:59:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:59:07 INFO - 'SHELL': '/bin/bash', 03:59:07 INFO - 'SHLVL': '1', 03:59:07 INFO - 'TERM': 'linux', 03:59:07 INFO - 'TMOUT': '86400', 03:59:07 INFO - 'USER': 'cltbld', 03:59:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1506507987.780939-191415187', 03:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:07 INFO - '_': '/tools/buildbot/bin/python'} 03:59:07 INFO - TEST-INFO | started process 28803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_yW5lf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:08 INFO - PID 28803 | 03:59:08 INFO - PID 28803 | (/builds/slave/test/build/application/firefox/firefox:28853): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:59:08 INFO - PID 28803 | 03:59:18 INFO - PID 28803 | RSS: Main: 152043520 03:59:18 INFO - PID 28803 | 03:59:21 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51998/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:22 INFO - PID 28803 | RSS: Main: 158543872 03:59:22 INFO - PID 28803 | 03:59:25 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51998/tests/kraken/driver.html?testName=audio-dft) 03:59:25 INFO - PID 28803 | RSS: Main: 158461952 03:59:25 INFO - PID 28803 | 03:59:28 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51998/tests/kraken/driver.html?testName=audio-fft) 03:59:29 INFO - PID 28803 | RSS: Main: 155291648 03:59:29 INFO - PID 28803 | 03:59:31 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51998/tests/kraken/driver.html?testName=audio-oscillator) 03:59:32 INFO - PID 28803 | RSS: Main: 155230208 03:59:32 INFO - PID 28803 | 03:59:34 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:34 INFO - PID 28803 | RSS: Main: 155455488 03:59:34 INFO - PID 28803 | 03:59:38 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51998/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:38 INFO - PID 28803 | RSS: Main: 157573120 03:59:38 INFO - PID 28803 | 03:59:42 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51998/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:42 INFO - PID 28803 | RSS: Main: 158081024 03:59:42 INFO - PID 28803 | 03:59:45 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51998/tests/kraken/driver.html?testName=json-parse-financial) 03:59:46 INFO - PID 28803 | RSS: Main: 157827072 03:59:46 INFO - PID 28803 | 03:59:48 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:48 INFO - PID 28803 | RSS: Main: 157954048 03:59:48 INFO - PID 28803 | 03:59:50 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:50 INFO - PID 28803 | RSS: Main: 157765632 03:59:50 INFO - PID 28803 | 03:59:53 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:53 INFO - PID 28803 | RSS: Main: 155029504 03:59:53 INFO - PID 28803 | 03:59:56 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:56 INFO - PID 28803 | RSS: Main: 155004928 03:59:56 INFO - PID 28803 | 04:00:00 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:00 INFO - PID 28803 | RSS: Main: 155246592 04:00:00 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | Cycle 1(1): loaded http://localhost:51998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51998/tests/kraken/driver.html?testName=ai-astar) 04:00:02 INFO - PID 28803 | RSS: Main: 156700672 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | __start_tp_report 04:00:02 INFO - PID 28803 | _x_x_mozilla_page_load 04:00:02 INFO - PID 28803 | _x_x_mozilla_page_load_details 04:00:02 INFO - PID 28803 | |i|pagename|runs| 04:00:02 INFO - PID 28803 | |0;ai-astar;109;108;110;108;109;111;111;110;109;110 04:00:02 INFO - PID 28803 | |1;audio-beat-detection;118;118;118;117;117;116;118;116;116;115 04:00:02 INFO - PID 28803 | |2;audio-dft;163;166;163;164;164;163;163;163;166;167 04:00:02 INFO - PID 28803 | |3;audio-fft;74;74;76;75;75;74;75;74;74;75 04:00:02 INFO - PID 28803 | |4;audio-oscillator;80;79;79;79;78;78;78;79;83;83 04:00:02 INFO - PID 28803 | |5;imaging-gaussian-blur;113;113;114;114;114;114;114;113;115;115 04:00:02 INFO - PID 28803 | |6;imaging-darkroom;153;147;147;148;148;147;148;148;149;147 04:00:02 INFO - PID 28803 | |7;imaging-desaturate;95;94;100;100;94;96;95;94;95;96 04:00:02 INFO - PID 28803 | |8;json-parse-financial;54;54;55;53;55;56;54;54;54;53 04:00:02 INFO - PID 28803 | |9;json-stringify-tinderbox;39;38;37;38;38;39;37;38;38;38 04:00:02 INFO - PID 28803 | |10;stanford-crypto-aes;74;75;76;72;74;74;74;73;74;74 04:00:02 INFO - PID 28803 | |11;stanford-crypto-ccm;115;119;114;120;111;114;127;116;113;116 04:00:02 INFO - PID 28803 | |12;stanford-crypto-pbkdf2;173;170;180;179;175;171;170;176;174;174 04:00:02 INFO - PID 28803 | |13;stanford-crypto-sha256-iterative;67;66;68;66;73;70;71;65;69;66 04:00:02 INFO - PID 28803 | __end_tp_report 04:00:02 INFO - PID 28803 | __start_cc_report 04:00:02 INFO - PID 28803 | _x_x_mozilla_cycle_collect,751 04:00:02 INFO - PID 28803 | __end_cc_report 04:00:02 INFO - PID 28803 | __startTimestamp1506510002691__endTimestamp 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | ------- Summary: start ------- 04:00:02 INFO - PID 28803 | Number of tests: 14 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.08 (1.0%) stddev-sans-first:1.13 04:00:02 INFO - PID 28803 | Values: 109.0 108.0 110.0 108.0 109.0 111.0 111.0 110.0 109.0 110.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:117.50 stddev:1.10 (0.9%) stddev-sans-first:1.09 04:00:02 INFO - PID 28803 | Values: 118.0 118.0 118.0 117.0 117.0 116.0 118.0 116.0 116.0 115.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.55 (0.9%) stddev-sans-first:1.58 04:00:02 INFO - PID 28803 | Values: 163.0 166.0 163.0 164.0 164.0 163.0 163.0 163.0 166.0 167.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#3] audio-fft Cycles:10 Average:74.60 Median:75.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 04:00:02 INFO - PID 28803 | Values: 74.0 74.0 76.0 75.0 75.0 74.0 75.0 74.0 74.0 75.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:79.00 stddev:1.90 (2.4%) stddev-sans-first:2.01 04:00:02 INFO - PID 28803 | Values: 80.0 79.0 79.0 79.0 78.0 78.0 78.0 79.0 83.0 83.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 04:00:02 INFO - PID 28803 | Values: 113.0 113.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 115.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.81 (1.2%) stddev-sans-first:0.71 04:00:02 INFO - PID 28803 | Values: 153.0 147.0 147.0 148.0 148.0 147.0 148.0 148.0 149.0 147.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.00 stddev:2.28 (2.4%) stddev-sans-first:2.40 04:00:02 INFO - PID 28803 | Values: 95.0 94.0 100.0 100.0 94.0 96.0 95.0 94.0 95.0 96.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 04:00:02 INFO - PID 28803 | Values: 54.0 54.0 55.0 53.0 55.0 56.0 54.0 54.0 54.0 53.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.67 (1.8%) stddev-sans-first:0.60 04:00:02 INFO - PID 28803 | Values: 39.0 38.0 37.0 38.0 38.0 39.0 37.0 38.0 38.0 38.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:1.05 (1.4%) stddev-sans-first:1.12 04:00:02 INFO - PID 28803 | Values: 74.0 75.0 76.0 72.0 74.0 74.0 74.0 73.0 74.0 74.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:116.00 stddev:4.55 (3.9%) stddev-sans-first:4.80 04:00:02 INFO - PID 28803 | Values: 115.0 119.0 114.0 120.0 111.0 114.0 127.0 116.0 113.0 116.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.50 stddev:3.46 (2.0%) stddev-sans-first:3.64 04:00:02 INFO - PID 28803 | Values: 173.0 170.0 180.0 179.0 175.0 171.0 170.0 176.0 174.0 174.0 04:00:02 INFO - PID 28803 | 04:00:02 INFO - PID 28803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:2.60 (3.8%) stddev-sans-first:2.73 04:00:02 INFO - PID 28803 | Values: 67.0 66.0 68.0 66.0 73.0 70.0 71.0 65.0 69.0 66.0 04:00:02 INFO - PID 28803 | -------- Summary: end -------- 04:00:02 INFO - PID 28803 | 04:00:03 INFO - PID 28803 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:00:03 INFO - TEST-INFO | 28803: exit 0 04:00:03 INFO - TEST-OK | kraken | took 60992ms 04:00:03 INFO - SUITE-END | took 1168s 04:00:03 INFO - Completed test suite (00:19:28) 04:00:03 INFO - javascript benchmark 04:00:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8493.46901809486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.5849310343106, 3078.815271083734, 3111.766617503687, 3112.7509799216064, 3159.889403870865, 6110.297315808683, 6189.164462797521, 6237.625742455456, 6258.687065646716, 6332.968335158329, 6138.570300078996, 6179.382061793818, 6230.127782110497, 6309.4636955858805, 6329.810105696825, 5811.738471768781, 5822.534197264209, 5862.530997520188, 5884.882302353951, 5924.763009479616, 33.14590115418763, 5663.5186009189265, 5737.110747834093, 5763.221965034709, 5841.474267315941, 5704.201411802351, 5714.114312281561, 5737.684427356494, 5793.652380857162, 5823.708814559276, 5717.371089180187, 5719.313682358102, 5769.88460230793, 5772.365039845614, 5816.331121920991, 5706.514946229576, 5735.4551317624755, 5767.567432442584, 5773.393793651648, 5807.738651760681, 6146.354632763585, 6247.781327653511, 6295.118683384329, 6307.432331090224, 6309.3059763426445, 6511.251206111263, 6546.70539825709, 6587.044878492639, 6646.0, 6651.501137414713, 6672.566283191577, 6701.061851340816, 6792.0, 6819.829504262383, 6822.761203357908, 6290.3709629037185, 6315.989441689354, 6320.968395158041, 6322.4942004639515, 6322.936770632326, 6915.654217289216, 6929.3070692931315, 6938.375546200765, 7011.579305241702, 7038.049863268496, 6392.616443013434, 6543.0, 6587.63767992765, 6659.367360100783, 6679.165104361955, 6595.637239951849, 6665.533412661067, 6666.26671066192, 6672.432843208382, 6680.565763225375, 6747.527673062838, 6757.797266082025, 6760.290169532227, 6767.796966091025, 6785.050092986986, 6699.363560461748, 6713.865722685617, 6714.261431242559, 6796.558223715443, 6806.55757375769, 5125.359330083739, 5197.272381866542, 5219.399769026534, 5293.20601909709, 5325.0148722486465, 4601.7699115044115, 4605.953940460619, 4627.5603817637275, 4666.136764698542, 4674.345591617176, 5655.406182350876, 5741.971290143606, 5754.079347304495, 5759.452851979056, 5767.480926716616, 6647.235567909655, 6648.069270302161, 6682.699278532477, 6743.831404214934, 6744.83137921546, 5576.1356989666665, 5602.215689803349, 5684.715764211773, 5688.033034384164, 5752.884942301214, 5789.1605717171615, 5797.623154494944, 5805.709714514257, 5812.186293918855, 5813.82558523245, 6268.153799237136, 6394.680265986682, 6403.48772098231, 6419.807405777834, 6420.165378500858, 6471.805845824632, 6657.700403481855, 6689.0, 6706.295838936841, 6718.8320291993095, 6419.2938776735455, 6421.967890160519, 6504.056911747864, 6505.0, 6557.836054098686, 6462.063000864942, 6539.705713243011, 6545.642022188855, 6639.535232533676, 6650.3682150195655, 6661.566998145105, 6677.232118306457, 6680.899786503303, 6685.298043705536, 6688.665566721742, 6436.227652681709, 6486.286508484157, 6568.507361947777, 6569.57297775643, 6580.8354791130605, 6459.095726598186, 6523.869522609426, 6563.310852360433, 6568.540202185801, 6578.967105164635, 6374.840628984312, 6392.712327945346, 6451.41937225652, 6459.967700161469, 6477.4170324671, 6422.871542569216, 6458.741650333934, 6463.935360646521, 6513.967430162819, 6527.477801775752, 6207.34822843613, 6392.584482008655, 6405.743770249138, 6415.326390729093, 6421.935780642134], "value": 6052.488796017149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [850.2815121222565, 875.4353442029891, 901.7835719427335, 903.6791938861704, 908.1281969309458, 40239.0, 40963.79518102413, 41422.792886035524, 41472.792636036815, 41512.79243603782, 38106.618933810656, 40587.188256234855, 41386.0, 41505.0, 41697.7915110424, 7911.960440197791, 8042.276195142436, 8045.678172873078, 8045.718399856006, 8075.273225409712, 7914.129445760962, 8011.639476223584, 8034.196580341977, 8036.27673509384, 8037.477563958324, 8047.51714897108, 8055.234752698513, 8057.194280571925, 8058.798530036737, 8077.7576672699915, 8013.118556958759, 8038.276555110039, 8042.034955805282, 8045.356371490267, 8079.878801817978, 7808.492447990862, 7870.72452464161, 7872.370210383213, 7872.763817085496, 7890.329322007637, 38493.42259866104, 38652.80673596642, 38694.419583706265, 38714.0, 38737.03157421059, 3543.2382037861985, 3574.3566158091535, 3586.1393265616066, 3591.7306202034692, 3602.2975519773654, 31847.203819904455, 31866.203344916332, 31929.52105718416, 31968.0, 32004.0, 4998.975005124988, 5228.47715228478, 5254.842354729364, 5282.894342113136, 5288.6826790392315, 186992.06503967394, 187412.0, 187906.0, 188278.0, 188981.99999999863, 46295.76852115785, 46412.767936160104, 46480.0, 46526.534734652894, 46599.76700116478, 48973.51026489761, 52688.0, 53468.0, 53479.73260133674, 53546.46453535493, 13726.382312795948, 13809.240491772847, 13819.170849749047, 13860.653483662989, 13882.375293111834, 12198.268103913793, 12421.130520863453, 12428.067894907737, 12433.254004759743, 12433.875661243272, 14163.929180354238, 14316.355763990645, 14383.208923509308, 14386.712265754626, 14473.0, 5694.345150307685, 5695.145728140812, 5798.681072540966, 5804.680742559115, 5898.8230353089475, 992.8659630949874, 996.2876543271595, 1000.8548760429696, 1011.5751384418562, 1024.538957469142, 22531.43671408228, 22822.65766013511, 22945.655815162787, 23221.0, 23616.17343392973, 1063.8776540697763, 1093.2565855218368, 1098.6813823990954, 1099.587654629514, 1100.1199040767515, 12221.388930553438, 12230.0, 12307.507699691912, 12444.81332780009, 12484.500619975099, 237855.0, 238555.0, 239278.0, 239298.0, 239927.0, 43892.78053609712, 45010.77494612506, 51757.7412112937, 52692.0, 52976.73511632417, 1414.533204042684, 1420.872121509069, 1430.8640679135465, 1432.4771458417601, 1436.346462359624, 26670.466590668468, 26678.333041674112, 26888.32779180536, 26903.0, 27148.1855544334, 36179.0, 36223.818880905426, 36450.27099458049, 36523.26953460969, 36694.0, 191289.0, 191349.0, 192294.0, 192370.0, 192999.0, 32368.514472283405, 33503.162420938694, 33948.151296216805, 34245.82877085599, 34276.48585271173, 41250.38124428196, 42908.570914291704, 43119.56880431156, 43189.352159718255, 43504.0, 31178.844105780234, 31213.53179702261, 31333.52999705052, 31541.52687709732, 31808.0, 30256.243593910327, 30802.845985770826, 31219.687803121677, 31641.8417907909, 31938.52092218665, 35151.29697406089, 35182.0, 35210.0, 35265.647343527264, 35463.468047978786, 30687.386252274384, 30695.539566906962, 30738.385232295677, 31241.218969525944, 31656.208594785316, 22700.318990430314, 22935.541289174456, 23037.308880733606, 23138.884305578365, 23416.180433684738], "value": 17120.243775134728, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.6936197220404, 609.923759530059, 613.895637741584, 620.5656040771461, 628.5034822490231, 21898.89050554747, 22585.887070564666, 22656.546869062608, 22670.206542771008, 22671.20650777221, 20445.284415045477, 24213.878930605366, 24350.512989740193, 24380.75619243807, 24432.511349772994, 6400.871982560346, 6585.275619681831, 6592.406683398493, 6594.4065034146915, 6598.901016484757, 6342.841428964267, 6443.162388889461, 6570.540062195648, 6612.603243805363, 6637.933620663804, 6593.736250549972, 6598.142241508621, 6598.439132673729, 6601.966990165042, 6604.966975165142, 6241.500679945593, 6603.93396066038, 6606.174228221473, 6619.205695316568, 6620.139381880349, 6060.787872424444, 6065.5450841187085, 6080.513558915276, 6082.422169893853, 6085.330613632541, 27948.301292467648, 28376.0, 28491.85754071237, 28527.429451410855, 28589.142325730263, 2106.494441334084, 2107.862988905716, 2128.4146859613575, 2135.5088329684104, 2137.95724085519, 18749.62500749991, 19175.61648767017, 19493.610127797507, 19555.706664400044, 19655.508612284666, 2389.784919357266, 2422.697162854643, 2449.3876530867283, 2457.213691618683, 2464.051340234023, 121557.39221303926, 128134.35932820276, 133521.0, 140457.99999999898, 140769.0, 14599.15107311539, 14628.853711462749, 14685.527834546658, 14731.558053258419, 14744.909174477041, 22843.543129137324, 22982.42543936415, 22986.42533936665, 23134.305970820904, 23165.189218377276, 9451.574679139456, 9495.335326527076, 9519.0, 9555.713328600154, 9585.520723963775, 8395.62219700115, 8455.74632761018, 8495.277901378453, 8559.614817333235, 8583.227509524173, 8681.348898832613, 8882.15619516145, 8956.596953137125, 8980.685676001309, 9181.954090229507, 2711.823731457449, 2719.0619236363423, 2740.287525243411, 2756.503829310703, 2822.0, 958.3435346787472, 965.5558443116105, 981.0385821894583, 984.8867380251363, 989.4656885281867, 18375.173117209757, 18680.906595467208, 18840.43478695641, 18935.621287574173, 19145.2341906325, 1016.4714348538719, 1022.6983040003217, 1031.6286136990677, 1035.2856528994969, 1036.9222308326905, 10075.395476271447, 10252.794944101226, 10289.43408112546, 10335.844962325571, 10640.042396184226, 464697.0, 472034.0, 487393.0, 489644.0, 490855.0, 108456.4577177109, 113455.0, 113550.0, 114183.0, 114516.0, 1145.1869172887343, 1152.4929031226234, 1172.6364826903687, 1173.6537721372215, 1173.7065733566608, 16955.745663814807, 17002.064886431366, 17129.571760706083, 17306.913465432594, 17504.82495175083, 53804.0, 54496.45503544914, 54497.18254226111, 55222.0, 55456.72271638616, 67055.66472167608, 67168.6641566789, 67200.32799672136, 69493.65253173701, 70094.29905700877, 13659.180449173082, 14190.0, 14202.0, 14216.644583885485, 14224.857751422353, 21519.569608608053, 21916.12335506626, 21999.890000550535, 22077.889610552487, 22147.889260553595, 17591.472255832345, 17928.462146135636, 17955.0, 17975.550611234823, 17998.460046198634, 15752.291146898646, 15953.521394358188, 16042.67914641724, 16080.195990200209, 16480.42318518846, 17319.913400432917, 17565.946043237447, 18029.278828847226, 18178.45464636063, 18217.90891045589, 13769.931150344584, 13874.653133671336, 14046.78929816033, 14059.297035147996, 14132.0, 17072.57318567046, 17238.138093095546, 17277.56806079858, 17415.56461088483, 17453.30186792514], "value": 11696.022219293094, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.7893137098067, 1362.8500864904859, 1372.512757970921, 1383.59184040708, 1394.9790753138698, 15173.620659483518, 15919.0, 15950.601234969132, 15978.680426391466, 15988.600284992866, 15740.0, 15893.84106158938, 15897.52307430776, 15921.442749503769, 15922.283497242623, 2756.3660358117645, 2762.9171124866234, 2792.5531914893622, 2792.860356982153, 2804.2708895687065, 2698.4198397344567, 2728.4406696627243, 2737.178846346098, 2739.369944912671, 2745.4646343962936, 2637.525245455817, 2744.698083210845, 2756.1731480555854, 2757.931051723713, 2758.8344699318004, 2720.9727902720915, 2765.9308517287027, 2783.7772978161697, 2795.0915952315477, 2798.0906205483197, 2728.6589176352954, 2762.309422644339, 2766.432881259337, 2774.5838124281518, 2781.8887244510197, 15044.473443429428, 15330.770038449433, 15381.538553843402, 15383.538493845203, 15387.615309617237, 7841.607919604054, 8073.990751156105, 8080.313173380269, 8117.431779775418, 8118.431709780259, 5152.4847515248175, 5167.586593072545, 5181.404138524081, 5206.219067139959, 5252.448492908266, 1796.4790210838842, 1828.1133650179652, 1850.1211924335832, 1877.8685492015563, 1894.6400183965002, 27981.860090699618, 28084.157475275773, 28143.718562814316, 28287.85856070727, 28305.15084547467, 6787.389134977876, 6864.141982252218, 6899.827504312332, 7002.089728335284, 7042.894356584656, 17937.820621793875, 17949.7307540387, 17974.1012949352, 18053.187606557738, 18175.09124543794, 7945.920540794518, 7970.840583188304, 8019.719309824128, 8058.274755272054, 8061.153578874251, 7260.947162661385, 7365.484416090822, 7442.957985881981, 7451.366633836076, 7497.737579184703, 5184.714840683799, 5336.973315133399, 5372.7313634318125, 5392.757325920343, 5400.189971504227, 1357.6402253402857, 1407.9507217247346, 1472.63184203949, 1483.4437086092714, 1506.5480355893187, 790.8892755014302, 867.8741582470507, 921.3642586615214, 926.1803304075942, 934.5187228577288, 7708.03649543807, 7725.459217854808, 7727.884081738666, 7756.108047574488, 7895.7236496722335, 969.970900872975, 973.2943615878431, 981.5877331520778, 983.7393090830935, 987.09680642213, 4672.6261899047995, 4850.490698476679, 4865.9756701216265, 4872.731999739977, 4897.877553061202, 20613.896930515253, 21926.45183870384, 22202.111915523197, 22497.775022249894, 22501.662475062887, 21807.67288490674, 22079.227227046977, 22220.555588888456, 22250.109995599996, 22352.0, 11099.500522476508, 11146.665600032013, 11198.328100314007, 11295.548178072784, 11344.546218151347, 8356.749297521084, 8415.495070295801, 8453.281471075028, 8501.914980850359, 8502.957485212535, 18304.26782928668, 18511.166997484877, 18946.0, 18951.0, 19240.71138932945, 18886.905565472083, 18960.715589265896, 19013.14440850193, 19053.618927621646, 19252.711209332152, 11283.774324513299, 11414.0, 11417.31496110236, 11491.942540287246, 11526.654200374001, 13984.790228146789, 14061.156330620195, 14095.506657266946, 14106.576802695936, 14135.15189088658, 11645.243059201124, 11672.70818229551, 11889.28664280146, 11996.0, 12034.939825300817, 11305.773884522428, 11509.424528773361, 11510.42447877586, 11733.413329333669, 11877.168598198388, 10260.692179234635, 10319.071283584513, 10524.31591946521, 10550.89449105499, 10556.0, 7299.379552738077, 7495.962520187582, 7542.962285188539, 7583.9620801895635, 7606.391488681003, 7489.101307843093, 7524.510906791041, 7527.8118047049265, 7617.200193979774, 7716.305532502101], "value": 6753.832540802959, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.5831876180295, 523.7302789063633, 539.8731298144936, 543.8694713268817, 549.9092649712798, 6077.787277445284, 6164.81505554833, 6182.196314479117, 6235.906461403082, 6293.4335909768115, 6125.356837532062, 6169.3830616938285, 6171.81484555463, 6238.719257633406, 6242.406971337716, 5163.941392014628, 5203.68777873327, 5206.895862082756, 5224.0, 5255.448177941318, 4852.320675105488, 5041.3194218780545, 5044.82343117991, 5057.848264552069, 5082.415522214956, 5010.173321401964, 5029.924551131736, 5038.395392552899, 5052.368453943257, 5079.314292570492, 4994.775235114428, 4998.60011199105, 5014.6991180529285, 5044.9747751261375, 5070.594352451795, 4558.339040839093, 4569.177548041352, 4578.153041687298, 4588.105319462706, 4621.237495813187, 6071.241094863142, 6178.135061091406, 6207.4723648489935, 6241.438270555672, 6319.33646967071, 5664.0, 5689.630174038674, 5704.857378565527, 5753.654780713129, 5774.884502309972, 6443.0, 6520.706568204442, 6577.177852768404, 6602.141721576212, 6608.173978252718, 4909.263610458424, 4918.606511479109, 4965.801367945278, 4970.304157417964, 4996.100701873661, 6813.921753865069, 6816.659167041628, 6865.828354291183, 6899.689513971884, 6937.930620693829, 5008.023435430056, 5064.518870707277, 5081.364829396325, 5090.618203634668, 5108.438071812097, 5158.8968220636125, 5176.094183517869, 5181.740912954413, 5217.373915130209, 5227.712475813791, 5732.197492351074, 5736.1682556029145, 5785.855353616109, 5791.82624521265, 5794.232759008542, 6298.307186209513, 6356.45970092538, 6479.287278399373, 6663.4669226461765, 6699.229588597276, 1748.7059575913731, 1769.0, 1781.3141940353057, 1788.847947924415, 1804.592417914029, 1083.6044843632176, 1217.5616777959926, 1222.9938850305691, 1227.656256248252, 1241.4351470081272, 5518.889622207534, 5600.355959064678, 5645.943540564542, 5665.235193248941, 5669.744861481243, 6618.98836029615, 6677.332266773284, 6690.0, 6778.627175505395, 6786.389224969677, 5635.380108188096, 5657.094864821609, 5660.179274005246, 5683.2895888014, 5725.8568535786935, 3481.7388695847912, 3519.9472007919903, 3521.595016573127, 3537.2748586539697, 3620.7646502977223, 6406.4554512866, 6415.615063096229, 6456.192975878015, 6477.870442591122, 6521.771737989243, 6799.082123913208, 6822.181338239344, 6833.863322733518, 6893.75871844483, 6940.271271516418, 6430.549861509649, 6455.838604034937, 6481.902771458432, 6572.6056436613, 6572.901406479003, 6547.220529013752, 6558.409743123142, 6608.240052394036, 6682.164729408824, 6686.665666716742, 6568.9014664781025, 6616.603003819594, 6627.966860165669, 6635.535512514078, 6664.266930637529, 6537.215534135934, 6561.376669216417, 6562.310957349409, 6563.803085907431, 6566.6388348639375, 4943.3573635427165, 4968.608789538935, 5020.774065167003, 5034.244863270393, 5034.270030845581, 6754.5609535380045, 6789.524733268624, 6807.863842723217, 6807.863842723217, 6812.897806533005, 6488.286288508355, 6498.480121590356, 6535.4444872184495, 6595.340465953366, 6600.636964966973, 6555.639439830855, 6561.245456772342, 6563.901541476977, 6580.341965803382, 6583.485798266522, 6442.420182183626, 6450.838729031811, 6465.741370345134, 6473.126127972663, 6487.772927947499, 6237.844053898689, 6541.934580654132, 6578.8355291118105, 6608.546119853624, 6656.73373065072, 6362.331955144643, 6392.456641185366, 6405.459277724828, 6436.645984470899, 6454.806355809145], "value": 5078.91680945191, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.477143256911, 906.2478143141198, 916.340235030778, 924.7318277699468, 930.0885132570086, 19279.228830846765, 20300.0, 20314.288999885008, 20497.692534611957, 20633.793662063374, 19805.0, 21719.193176989123, 21821.345359639196, 21977.780222197773, 22160.002799874044, 974.7514383832131, 1001.3491230700031, 1003.8945910679383, 1003.9899601004006, 1004.3823048824993, 984.251968503935, 988.0810845913297, 994.1599348550463, 995.2485873165786, 1006.4716024087339, 1053.5522402978704, 1057.735566108473, 1061.124572227915, 1061.5753698520575, 1061.7133373989057, 1058.4919238765358, 1061.0344586426315, 1061.3366645846345, 1061.920355973305, 1064.9680509584687, 774.6475353714046, 775.6432041261027, 775.9340456061242, 777.6189667063098, 779.9142094369615, 19136.330228442075, 20878.47803804902, 21061.368158955254, 21068.157273709032, 21077.367678969655, 21748.13007479699, 22033.228836990627, 22107.557848842935, 22245.11019559216, 22305.888470557704, 16949.0, 17304.567385815328, 17379.73930391045, 17451.650966980716, 17506.037167955757, 3779.9244015119543, 3815.3704638734575, 3817.1983883384523, 3817.790021548814, 3819.8472061117523, 134069.0, 136658.0, 136873.0, 139369.0, 142686.0, 17294.394696185573, 17343.479695609152, 17405.65188696219, 17597.736033959245, 17635.911820440815, 31346.84326578398, 31501.054968350985, 31613.36773264522, 31635.683643163735, 31796.68203317937, 8445.915540844635, 8628.568571571523, 8636.913630863737, 8715.0, 8740.694075707319, 4001.359782434855, 4165.625093741578, 4175.770332631673, 4191.015111448807, 4196.99272174682, 5470.56235501159, 5518.061929471919, 5560.4161563035295, 5561.443855614487, 5566.972165139148, 988.1353815411514, 1001.5643195210107, 1002.3334482569155, 1019.7399663086014, 1021.4024795494719, 667.2626747444004, 679.9320067993161, 690.0408432279136, 693.7051753005054, 698.333091897237, 11125.388103654215, 11586.553065198, 11830.467628956545, 12340.629781106582, 12481.375931203404, 675.9560628559226, 688.6074937285699, 695.0010703813031, 706.156143408632, 709.762229653072, 5426.403095659474, 5487.110880373741, 5525.419830917776, 5605.327360716658, 5657.179708942181, 118708.40645796715, 121333.39333303277, 123893.38053309676, 125024.37487812685, 126736.0, 107814.46092769486, 110074.44962775295, 110165.0, 111248.44375778231, 112859.43570282261, 98605.50697246612, 99902.50048749709, 100619.0, 100737.0, 102104.48947755214, 10328.483575821328, 10384.42885641297, 10441.373517588969, 10531.526081326512, 10535.420551869414, 45065.54934450614, 45494.77252613716, 45770.31344529901, 46096.53903461056, 46111.07777844492, 57107.428925710214, 57280.0, 57338.42661573331, 58132.4186758127, 58740.0, 15390.461333853262, 15471.071735695894, 15607.453739119077, 15649.608759781097, 15719.371225150866, 16158.919205403898, 16216.918915405347, 16319.0, 16389.918050409673, 16408.09755463461, 14488.203148826915, 14645.780313295521, 14782.334794934039, 14807.777883331973, 14823.481178158712, 14891.106533608017, 15277.77083343773, 15311.0, 15398.692026159639, 15467.149306788235, 15862.841371586597, 15897.0, 15912.363505459653, 15921.761173582174, 15977.8402215981, 12020.459079341275, 12120.393980300772, 12255.0, 12381.257124572554, 12530.686732831753, 11988.0, 12035.879641203475, 12239.0, 12310.446029928853, 12495.750084998432], "value": 9029.8756914983, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 110.0, 108.0, 109.0, 111.0, 111.0, 110.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 116.0, 118.0, 116.0, 116.0, 115.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 164.0, 164.0, 163.0, 163.0, 163.0, 166.0, 167.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 75.0, 75.0, 74.0, 75.0, 74.0, 74.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 78.0, 78.0, 78.0, 79.0, 83.0, 83.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 100.0, 100.0, 94.0, 96.0, 95.0, 94.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 53.0, 55.0, 56.0, 54.0, 54.0, 54.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 37.0, 38.0, 38.0, 39.0, 37.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 72.0, 74.0, 74.0, 74.0, 73.0, 74.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 119.0, 114.0, 120.0, 111.0, 114.0, 127.0, 116.0, 113.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 180.0, 179.0, 175.0, 171.0, 170.0, 176.0, 174.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 73.0, 70.0, 71.0, 65.0, 69.0, 66.0], "value": 68.1, "unit": "score"}]}]} 04:00:03 INFO - Return code: 0 04:00:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:03 INFO - # TBPL SUCCESS # 04:00:03 INFO - Running post-action listener: _package_coverage_data 04:00:03 INFO - Running post-action listener: _resource_record_post_action 04:00:03 INFO - [mozharness: 2017-09-27 11:00:03.462024Z] Finished run-tests step (success) 04:00:03 INFO - Running post-run listener: _resource_record_post_run 04:00:03 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 341753856; Read time: 12; Write time: 240172 04:00:03 INFO - TinderboxPrint: CPU usage
13.1% 04:00:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:00:03 INFO - TinderboxPrint: I/O write bytes / time
341,753,856 / 240,172 04:00:03 INFO - TinderboxPrint: CPU idle
8,219.8 (86.9%) 04:00:03 INFO - TinderboxPrint: CPU user
1,193.5 (12.6%) 04:00:03 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12685312; Read time: 0; Write time: 4772 04:00:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:00:03 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 327606272; Read time: 0; Write time: 235056 04:00:04 INFO - Running post-run listener: _upload_blobber_files 04:00:04 INFO - Blob upload gear active. 04:00:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:04 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 04:00:04 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:04 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:05 INFO - (blobuploader) - INFO - Done attempting. 04:00:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:13 INFO - (blobuploader) - INFO - Done attempting. 04:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:14 INFO - (blobuploader) - INFO - Done attempting. 04:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:15 INFO - (blobuploader) - INFO - Done attempting. 04:00:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:15 INFO - Return code: 0 04:00:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d8ce797750bef5e85cbf0614a6db2bbc60ab8329577c5c3ff063e4856875b40b584325339c5966ba48cde77c62e584a679fc0284d1479c9d53a512e17363909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe43cfcb63be7224aa9214b2fdd13524c9a075c953c3e88be7d5c7ec4f1558f4ed67730c3e6be3ecfc56d1f39236c39e7a162799cc0b5d547873d59fc203b05", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351a62c86fd6232747d899d10602376393ad8cfe8101ee6a526b15233398e1ecd21eadf23c47536bdefc6b52f360179b9fa70aa5f7a6bcd3f4858a4c4bdf0ce4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd06d5a6bde55082febadfb6cc417b7e9a859830926928a561cfdb9e5577488b8681a26f92c06760606d31953a15cb04dedd165aef474e289fb8c117645be272"} 04:00:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:15 INFO - Contents: 04:00:15 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d8ce797750bef5e85cbf0614a6db2bbc60ab8329577c5c3ff063e4856875b40b584325339c5966ba48cde77c62e584a679fc0284d1479c9d53a512e17363909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe43cfcb63be7224aa9214b2fdd13524c9a075c953c3e88be7d5c7ec4f1558f4ed67730c3e6be3ecfc56d1f39236c39e7a162799cc0b5d547873d59fc203b05", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351a62c86fd6232747d899d10602376393ad8cfe8101ee6a526b15233398e1ecd21eadf23c47536bdefc6b52f360179b9fa70aa5f7a6bcd3f4858a4c4bdf0ce4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd06d5a6bde55082febadfb6cc417b7e9a859830926928a561cfdb9e5577488b8681a26f92c06760606d31953a15cb04dedd165aef474e289fb8c117645be272"} 04:00:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:15 INFO - Copying logs to upload dir... 04:00:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.876545 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-27 04:00:15.786335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:00:15.791387) ========= 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=745a4373a2a16df560f216e000000264-1506507987.780939-191415187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d8ce797750bef5e85cbf0614a6db2bbc60ab8329577c5c3ff063e4856875b40b584325339c5966ba48cde77c62e584a679fc0284d1479c9d53a512e17363909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe43cfcb63be7224aa9214b2fdd13524c9a075c953c3e88be7d5c7ec4f1558f4ed67730c3e6be3ecfc56d1f39236c39e7a162799cc0b5d547873d59fc203b05", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351a62c86fd6232747d899d10602376393ad8cfe8101ee6a526b15233398e1ecd21eadf23c47536bdefc6b52f360179b9fa70aa5f7a6bcd3f4858a4c4bdf0ce4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd06d5a6bde55082febadfb6cc417b7e9a859830926928a561cfdb9e5577488b8681a26f92c06760606d31953a15cb04dedd165aef474e289fb8c117645be272"} build_url:https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/Epxi0CdYQW63JHszs_NJbg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3d8ce797750bef5e85cbf0614a6db2bbc60ab8329577c5c3ff063e4856875b40b584325339c5966ba48cde77c62e584a679fc0284d1479c9d53a512e17363909", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe43cfcb63be7224aa9214b2fdd13524c9a075c953c3e88be7d5c7ec4f1558f4ed67730c3e6be3ecfc56d1f39236c39e7a162799cc0b5d547873d59fc203b05", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/351a62c86fd6232747d899d10602376393ad8cfe8101ee6a526b15233398e1ecd21eadf23c47536bdefc6b52f360179b9fa70aa5f7a6bcd3f4858a4c4bdf0ce4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd06d5a6bde55082febadfb6cc417b7e9a859830926928a561cfdb9e5577488b8681a26f92c06760606d31953a15cb04dedd165aef474e289fb8c117645be272"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 04:00:15.827445) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:00:15.827794) ========= 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=745a4373a2a16df560f216e000000264-1506507987.780939-191415187 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 04:00:15.912950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:00:15.913277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 04:00:15.913654) ========= ========= Total master_lag: 0.24 =========