builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-073 starttime: 1506162986.84 results: success (0) revision: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.844250) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.844676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.844963) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.862250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.862601) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 03:36:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.2M=0s 2017-09-23 03:36:26 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.970603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:26.970991) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019389 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.024202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.024629) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 --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 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 --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=9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 03:36:27,068 truncating revision to first 12 chars 2017-09-23 03:36:27,068 Setting DEBUG logging. 2017-09-23 03:36:27,068 attempt 1/10 2017-09-23 03:36:27,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c3a15583223?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 03:36:27,672 unpacking tar archive at: mozilla-central-8c3a15583223/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936644 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.978642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.978974) ========= script_repo_revision: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.979361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.979646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 03:36:27.992442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 03:36:27.992861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:36:28 INFO - MultiFileLogger online at 20170923 03:36:28 in /builds/slave/test 03:36:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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:36:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:28 INFO - {'append_to_log': False, 03:36:28 INFO - 'base_work_dir': '/builds/slave/test', 03:36:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:36:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:28 INFO - 'branch': 'Firefox-Non-PGO', 03:36:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:28 INFO - 'code_coverage': False, 03:36:28 INFO - 'config_files': ('talos/linux_config.py',), 03:36:28 INFO - 'default_actions': ('clobber', 03:36:28 INFO - 'read-buildbot-config', 03:36:28 INFO - 'download-and-extract', 03:36:28 INFO - 'populate-webroot', 03:36:28 INFO - 'create-virtualenv', 03:36:28 INFO - 'install', 03:36:28 INFO - 'setup-mitmproxy', 03:36:28 INFO - 'run-tests'), 03:36:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:28 INFO - 'disable_ccov_upload': False, 03:36:28 INFO - 'disable_stylo': False, 03:36:28 INFO - 'download_minidump_stackwalk': True, 03:36:28 INFO - 'download_symbols': 'ondemand', 03:36:28 INFO - 'enable_stylo': False, 03:36:28 INFO - 'enable_webrender': False, 03:36:28 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:36:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:28 INFO - 'gecko_profile': False, 03:36:28 INFO - 'gecko_profile_interval': 0, 03:36:28 INFO - 'installer_path': 'installer.exe', 03:36:28 INFO - 'log_level': 'info', 03:36:28 INFO - 'log_name': 'talos', 03:36:28 INFO - 'log_to_console': True, 03:36:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:36:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:36:28 INFO - 'opt_config_files': (), 03:36:28 INFO - 'pip_index': False, 03:36:28 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:36:28 INFO - 'system_bits': '32', 03:36:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:28 INFO - 'title': 'talos-linux64-ix-073', 03:36:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:28 INFO - 'use_talos_json': True, 03:36:28 INFO - 'verify': 'False', 03:36:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:28 INFO - 'work_dir': 'build'} 03:36:28 INFO - [mozharness: 2017-09-23 10:36:28.185875Z] Running clobber step. 03:36:28 INFO - Running pre-action listener: _resource_record_pre_action 03:36:28 INFO - Running main action method: clobber 03:36:28 INFO - rmtree: /builds/slave/test/build 03:36:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:29 INFO - Running post-action listener: _resource_record_post_action 03:36:29 INFO - [mozharness: 2017-09-23 10:36:29.253042Z] Finished clobber step (success) 03:36:29 INFO - [mozharness: 2017-09-23 10:36:29.253139Z] Running read-buildbot-config step. 03:36:29 INFO - Running pre-action listener: _resource_record_pre_action 03:36:29 INFO - Running main action method: read_buildbot_config 03:36:29 INFO - Using buildbot properties: 03:36:29 INFO - { 03:36:29 INFO - "project": "", 03:36:29 INFO - "product": "firefox", 03:36:29 INFO - "who": "archaeopteryx@coole-files.de", 03:36:29 INFO - "installer_path": "public/build/target.tar.bz2", 03:36:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:36:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:36:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:36:29 INFO - "stage_platform": "linux64", 03:36:29 INFO - "basedir": "/builds/slave/test", 03:36:29 INFO - "buildnumber": 61, 03:36:29 INFO - "platform": "ubuntu64_hw", 03:36:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:36:29 INFO - "slavebuilddir": "test", 03:36:29 INFO - "taskId": "dLt2eEb3QxyEQZJ0aRwe1g", 03:36:29 INFO - "branch": "mozilla-central", 03:36:29 INFO - "script_repo_revision": "production", 03:36:29 INFO - "revision": "8c3a1558322331c1fab9d1d2d7a94ef69f2a9212", 03:36:29 INFO - "slavename": "talos-linux64-ix-073", 03:36:29 INFO - "repo_path": "mozilla-central" 03:36:29 INFO - } 03:36:29 INFO - Finding installer, test and symbols from parent task. 03:36:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLt2eEb3QxyEQZJ0aRwe1g'}, attempt #1 03:36:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dLt2eEb3QxyEQZJ0aRwe1g'}, attempt #1 03:36:30 INFO - Task dependencies: O6UesEjKQLKs2XYkonDMAA 03:36:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA'}, attempt #1 03:36:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2 03:36:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.test_packages.json 03:36:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.crashreporter-symbols.zip 03:36:30 INFO - Running post-action listener: _resource_record_post_action 03:36:30 INFO - [mozharness: 2017-09-23 10:36:30.610528Z] Finished read-buildbot-config step (success) 03:36:30 INFO - [mozharness: 2017-09-23 10:36:30.610784Z] Running download-and-extract step. 03:36:30 INFO - Running pre-action listener: _resource_record_pre_action 03:36:30 INFO - Running main action method: download_and_extract 03:36:30 INFO - mkdir: /builds/slave/test/build/tests 03:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:30 INFO - trying https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.test_packages.json 03:36:30 INFO - Downloading https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:36:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:36:31 INFO - Downloaded 989 bytes. 03:36:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:36:31 INFO - Using the following test package requirements: 03:36:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:36:31 INFO - u'common': [u'target.common.tests.zip'], 03:36:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:36:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:36:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:36:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:36:31 INFO - u'mozbase': [u'target.common.tests.zip'], 03:36:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:36:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:36:31 INFO - u'web-platform': [u'target.common.tests.zip', 03:36:31 INFO - u'target.web-platform.tests.tar.gz'], 03:36:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:36:31 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:36:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.common.tests.zip 03:36:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:36:31 INFO - Fetch https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.common.tests.zip into memory 03:36:32 INFO - Content-Length response header: 54943889 03:36:32 INFO - Bytes received: 54943889 03:36:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.talos.tests.zip 03:36:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:36:43 INFO - Fetch https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.talos.tests.zip into memory 03:36:44 INFO - Content-Length response header: 14513823 03:36:44 INFO - Bytes received: 14513823 03:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:44 INFO - trying https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2 03:36:44 INFO - Downloading https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:36:45 INFO - Downloaded 61717343 bytes. 03:36:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2 03:36:45 INFO - mkdir: /builds/slave/test/properties 03:36:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:45 INFO - Contents: 03:36:45 INFO - build_url:https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2 03:36:45 INFO - Running post-action listener: _resource_record_post_action 03:36:45 INFO - Running post-action listener: find_tests_for_verification 03:36:45 INFO - Running post-action listener: set_extra_try_arguments 03:36:45 INFO - [mozharness: 2017-09-23 10:36:45.925022Z] Finished download-and-extract step (success) 03:36:45 INFO - [mozharness: 2017-09-23 10:36:45.925117Z] Running populate-webroot step. 03:36:45 INFO - Running pre-action listener: _resource_record_pre_action 03:36:45 INFO - Running main action method: populate_webroot 03:36:45 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:45 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['tresize', 03:36:45 INFO - 'tcanvasmark']}, 03:36:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:45 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['dromaeo_css', 03:36:45 INFO - 'kraken']}, 03:36:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:45 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'tests': ['damp', 'tps']}, 03:36:45 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['damp', 'tps']}, 03:36:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:45 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['dromaeo_dom']}, 03:36:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:36:45 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['basic_compositor_video', 03:36:45 INFO - 'glvideo']}, 03:36:45 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:36:45 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['ts_paint_webext', 03:36:45 INFO - 'tp5o_webext']}, 03:36:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:45 INFO - 'ts_paint', 03:36:45 INFO - 'tpaint', 03:36:45 INFO - 'sessionrestore', 03:36:45 INFO - 'sessionrestore_many_windows', 03:36:45 INFO - 'sessionrestore_no_auto_restore', 03:36:45 INFO - 'tabpaint']}, 03:36:45 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['a11yr', 03:36:45 INFO - 'ts_paint', 03:36:45 INFO - 'tpaint', 03:36:45 INFO - 'sessionrestore', 03:36:45 INFO - 'sessionrestore_many_windows', 03:36:45 INFO - 'sessionrestore_no_auto_restore', 03:36:45 INFO - 'tabpaint']}, 03:36:45 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:36:45 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:36:45 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['perf_reftest_singletons']}, 03:36:45 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['perf_reftest']}, 03:36:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:45 INFO - 'tsvgr_opacity', 03:36:45 INFO - 'tart', 03:36:45 INFO - 'tscrollx', 03:36:45 INFO - 'tsvg_static']}, 03:36:45 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['tsvgx', 03:36:45 INFO - 'tsvgr_opacity', 03:36:45 INFO - 'tart', 03:36:45 INFO - 'tscrollx', 03:36:45 INFO - 'tsvg_static']}, 03:36:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:36:45 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'talos_options': ['--disable-stylo'], 03:36:45 INFO - 'tests': ['tp5o']}, 03:36:45 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:45 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:36:45 INFO - 'talos_options': ['--mitmproxy', 03:36:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:45 INFO - '--firstNonBlankPaint'], 03:36:45 INFO - 'tests': ['tp6_google', 03:36:45 INFO - 'tp6_youtube', 03:36:45 INFO - 'tp6_amazon', 03:36:45 INFO - 'tp6_facebook']}, 03:36:45 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:45 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:36:45 INFO - 'talos_options': ['--disable-stylo', 03:36:45 INFO - '--mitmproxy', 03:36:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:45 INFO - '--firstNonBlankPaint'], 03:36:45 INFO - 'tests': ['tp6_google', 03:36:45 INFO - 'tp6_youtube', 03:36:45 INFO - 'tp6_amazon', 03:36:45 INFO - 'tp6_facebook']}, 03:36:45 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:45 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:36:45 INFO - 'talos_options': ['--stylo-threads=1', 03:36:45 INFO - '--mitmproxy', 03:36:45 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:45 INFO - '--firstNonBlankPaint'], 03:36:45 INFO - 'tests': ['tp6_google', 03:36:45 INFO - 'tp6_youtube', 03:36:45 INFO - 'tp6_amazon', 03:36:45 INFO - 'tp6_facebook']}, 03:36:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'talos_options': ['--xperf_path', 03:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:45 INFO - 'tests': ['tp5n']}, 03:36:45 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:36:45 INFO - 'talos_options': ['--disable-stylo', 03:36:45 INFO - '--xperf_path', 03:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:45 INFO - 'tests': ['tp5n']}}} 03:36:45 INFO - Running post-action listener: _resource_record_post_action 03:36:45 INFO - [mozharness: 2017-09-23 10:36:45.940451Z] Finished populate-webroot step (success) 03:36:45 INFO - [mozharness: 2017-09-23 10:36:45.940541Z] Running create-virtualenv step. 03:36:45 INFO - Running pre-action listener: _resource_record_pre_action 03:36:45 INFO - Running main action method: create_virtualenv 03:36:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:45 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:36:45 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:36:45 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:36:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:46 INFO - Installing pip...............done. 03:36:46 INFO - Return code: 0 03:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:36:46 INFO - Reading from file tmpfile_stdout 03:36:46 INFO - Output received: 03:36:46 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:36:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:36:46 INFO - Using env: {'DISPLAY': ':0', 03:36:46 INFO - 'HOME': '/home/cltbld', 03:36:46 INFO - 'LANG': 'en_US.UTF-8', 03:36:46 INFO - 'LANGUAGE': 'en_US:en', 03:36:46 INFO - 'LOGNAME': 'cltbld', 03:36:46 INFO - 'MAIL': '/var/mail/cltbld', 03:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:46 INFO - 'MOZ_NO_REMOTE': '1', 03:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:46 INFO - 'NO_EM_RESTART': '1', 03:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:46 INFO - 'PWD': '/builds/slave/test', 03:36:46 INFO - 'SHELL': '/bin/bash', 03:36:46 INFO - 'SHLVL': '1', 03:36:46 INFO - 'TERM': 'linux', 03:36:46 INFO - 'TMOUT': '86400', 03:36:46 INFO - 'USER': 'cltbld', 03:36:46 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:46 INFO - '_': '/tools/buildbot/bin/python'} 03:36:48 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:36:48 INFO - Downloading/unpacking pip>=1.5 03:36:48 INFO - Running setup.py egg_info for package pip 03:36:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:36:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:36:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:36:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:36:48 INFO - Installing collected packages: pip 03:36:48 INFO - Found existing installation: pip 1.1 03:36:48 INFO - Uninstalling pip: 03:36:48 INFO - Successfully uninstalled pip 03:36:48 INFO - Running setup.py install for pip 03:36:48 INFO - warning: no files found matching 'pip/cacert.pem' 03:36:48 INFO - warning: no files found matching '*.html' under directory 'docs' 03:36:48 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:36:48 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:36:48 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:36:48 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:36:48 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:36:48 INFO - Successfully installed pip 03:36:48 INFO - Cleaning up... 03:36:48 INFO - Return code: 0 03:36:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:48 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:36:48 INFO - Using env: {'DISPLAY': ':0', 03:36:48 INFO - 'HOME': '/home/cltbld', 03:36:48 INFO - 'LANG': 'en_US.UTF-8', 03:36:48 INFO - 'LANGUAGE': 'en_US:en', 03:36:48 INFO - 'LOGNAME': 'cltbld', 03:36:48 INFO - 'MAIL': '/var/mail/cltbld', 03:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:48 INFO - 'MOZ_NO_REMOTE': '1', 03:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:48 INFO - 'NO_EM_RESTART': '1', 03:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:48 INFO - 'PWD': '/builds/slave/test', 03:36:48 INFO - 'SHELL': '/bin/bash', 03:36:48 INFO - 'SHLVL': '1', 03:36:48 INFO - 'TERM': 'linux', 03:36:48 INFO - 'TMOUT': '86400', 03:36:48 INFO - 'USER': 'cltbld', 03:36:48 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:48 INFO - '_': '/tools/buildbot/bin/python'} 03:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:49 INFO - Downloading/unpacking psutil>=3.1.1 03:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:50 INFO - Installing collected packages: psutil 03:36:50 INFO - Running setup.py install for psutil 03:36:50 INFO - building 'psutil._psutil_linux' extension 03:36:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:36:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:36:50 INFO - building 'psutil._psutil_posix' extension 03:36:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:36:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:36:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:50 INFO - Successfully installed psutil 03:36:50 INFO - Cleaning up... 03:36:50 INFO - Return code: 0 03:36:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:50 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:36:50 INFO - Using env: {'DISPLAY': ':0', 03:36:50 INFO - 'HOME': '/home/cltbld', 03:36:50 INFO - 'LANG': 'en_US.UTF-8', 03:36:50 INFO - 'LANGUAGE': 'en_US:en', 03:36:50 INFO - 'LOGNAME': 'cltbld', 03:36:50 INFO - 'MAIL': '/var/mail/cltbld', 03:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:50 INFO - 'MOZ_NO_REMOTE': '1', 03:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:50 INFO - 'NO_EM_RESTART': '1', 03:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:50 INFO - 'PWD': '/builds/slave/test', 03:36:50 INFO - 'SHELL': '/bin/bash', 03:36:50 INFO - 'SHLVL': '1', 03:36:50 INFO - 'TERM': 'linux', 03:36:50 INFO - 'TMOUT': '86400', 03:36:50 INFO - 'USER': 'cltbld', 03:36:50 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:50 INFO - '_': '/tools/buildbot/bin/python'} 03:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:52 INFO - Installing collected packages: mozsystemmonitor 03:36:52 INFO - Running setup.py install for mozsystemmonitor 03:36:52 INFO - Successfully installed mozsystemmonitor 03:36:52 INFO - Cleaning up... 03:36:52 INFO - Return code: 0 03:36:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:36:52 INFO - Using env: {'DISPLAY': ':0', 03:36:52 INFO - 'HOME': '/home/cltbld', 03:36:52 INFO - 'LANG': 'en_US.UTF-8', 03:36:52 INFO - 'LANGUAGE': 'en_US:en', 03:36:52 INFO - 'LOGNAME': 'cltbld', 03:36:52 INFO - 'MAIL': '/var/mail/cltbld', 03:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:52 INFO - 'MOZ_NO_REMOTE': '1', 03:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:52 INFO - 'NO_EM_RESTART': '1', 03:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:52 INFO - 'PWD': '/builds/slave/test', 03:36:52 INFO - 'SHELL': '/bin/bash', 03:36:52 INFO - 'SHLVL': '1', 03:36:52 INFO - 'TERM': 'linux', 03:36:52 INFO - 'TMOUT': '86400', 03:36:52 INFO - 'USER': 'cltbld', 03:36:52 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:52 INFO - '_': '/tools/buildbot/bin/python'} 03:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:52 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:53 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:53 INFO - warning: no files found matching '*.txt' 03:36:53 INFO - no previously-included directories found matching 'build' 03:36:53 INFO - no previously-included directories found matching 'dist' 03:36:53 INFO - no previously-included directories found matching '.git*' 03:36:53 INFO - Installing collected packages: jsonschema, functools32 03:36:53 INFO - Running setup.py install for functools32 03:36:54 INFO - warning: no files found matching '*.txt' 03:36:54 INFO - no previously-included directories found matching 'build' 03:36:54 INFO - no previously-included directories found matching 'dist' 03:36:54 INFO - no previously-included directories found matching '.git*' 03:36:54 INFO - Successfully installed jsonschema functools32 03:36:54 INFO - Cleaning up... 03:36:54 INFO - Return code: 0 03:36:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:54 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:36:54 INFO - Using env: {'DISPLAY': ':0', 03:36:54 INFO - 'HOME': '/home/cltbld', 03:36:54 INFO - 'LANG': 'en_US.UTF-8', 03:36:54 INFO - 'LANGUAGE': 'en_US:en', 03:36:54 INFO - 'LOGNAME': 'cltbld', 03:36:54 INFO - 'MAIL': '/var/mail/cltbld', 03:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:54 INFO - 'MOZ_NO_REMOTE': '1', 03:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:54 INFO - 'NO_EM_RESTART': '1', 03:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:54 INFO - 'PWD': '/builds/slave/test', 03:36:54 INFO - 'SHELL': '/bin/bash', 03:36:54 INFO - 'SHLVL': '1', 03:36:54 INFO - 'TERM': 'linux', 03:36:54 INFO - 'TMOUT': '86400', 03:36:54 INFO - 'USER': 'cltbld', 03:36:54 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:54 INFO - '_': '/tools/buildbot/bin/python'} 03:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:54 INFO - Cleaning up... 03:36:54 INFO - Return code: 0 03:36:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:54 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:54 INFO - Using env: {'DISPLAY': ':0', 03:36:54 INFO - 'HOME': '/home/cltbld', 03:36:54 INFO - 'LANG': 'en_US.UTF-8', 03:36:54 INFO - 'LANGUAGE': 'en_US:en', 03:36:54 INFO - 'LOGNAME': 'cltbld', 03:36:54 INFO - 'MAIL': '/var/mail/cltbld', 03:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:54 INFO - 'MOZ_NO_REMOTE': '1', 03:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:54 INFO - 'NO_EM_RESTART': '1', 03:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:54 INFO - 'PWD': '/builds/slave/test', 03:36:54 INFO - 'SHELL': '/bin/bash', 03:36:54 INFO - 'SHLVL': '1', 03:36:54 INFO - 'TERM': 'linux', 03:36:54 INFO - 'TMOUT': '86400', 03:36:54 INFO - 'USER': 'cltbld', 03:36:54 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:54 INFO - '_': '/tools/buildbot/bin/python'} 03:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:55 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:56 INFO - Downloading docopt-0.6.1.tar.gz 03:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:56 INFO - Running setup.py install for blobuploader 03:36:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:56 INFO - Running setup.py install for requests 03:36:56 INFO - Running setup.py install for docopt 03:36:56 INFO - Successfully installed blobuploader requests docopt 03:36:56 INFO - Cleaning up... 03:36:56 INFO - Return code: 0 03:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36: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:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36: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:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:56 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:56 INFO - Using env: {'DISPLAY': ':0', 03:36:56 INFO - 'HOME': '/home/cltbld', 03:36:56 INFO - 'LANG': 'en_US.UTF-8', 03:36:56 INFO - 'LANGUAGE': 'en_US:en', 03:36:56 INFO - 'LOGNAME': 'cltbld', 03:36:56 INFO - 'MAIL': '/var/mail/cltbld', 03:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:56 INFO - 'MOZ_NO_REMOTE': '1', 03:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:56 INFO - 'NO_EM_RESTART': '1', 03:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:56 INFO - 'PWD': '/builds/slave/test', 03:36:56 INFO - 'SHELL': '/bin/bash', 03:36:56 INFO - 'SHLVL': '1', 03:36:56 INFO - 'TERM': 'linux', 03:36:56 INFO - 'TMOUT': '86400', 03:36:56 INFO - 'USER': 'cltbld', 03:36:56 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:56 INFO - '_': '/tools/buildbot/bin/python'} 03:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:57 INFO - Running setup.py (path:/tmp/pip-Seg8bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:57 INFO - Running setup.py (path:/tmp/pip-fk8HYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:57 INFO - Running setup.py (path:/tmp/pip-e1aK0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:57 INFO - Running setup.py (path:/tmp/pip-OQf1XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:57 INFO - Running setup.py (path:/tmp/pip-sCsHoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:57 INFO - Running setup.py (path:/tmp/pip-uLZJ71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:57 INFO - Running setup.py (path:/tmp/pip-QiXw_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:57 INFO - Running setup.py (path:/tmp/pip-X4kNOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:57 INFO - Running setup.py (path:/tmp/pip-zuk3EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:57 INFO - Running setup.py (path:/tmp/pip-CtSo99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:57 INFO - Running setup.py (path:/tmp/pip-wsZn0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:57 INFO - Running setup.py (path:/tmp/pip-sxqcTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:57 INFO - Running setup.py (path:/tmp/pip-6PqJ_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:57 INFO - Running setup.py (path:/tmp/pip-Bmhn04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:58 INFO - Running setup.py (path:/tmp/pip-cTacbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:58 INFO - Running setup.py (path:/tmp/pip-53BMCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:58 INFO - Running setup.py (path:/tmp/pip-89xVj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:58 INFO - Running setup.py install for manifestparser 03:36:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Running setup.py install for mozcrash 03:36:58 INFO - Running setup.py install for mozdebug 03:36:58 INFO - Running setup.py install for mozdevice 03:36:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Running setup.py install for mozfile 03:36:58 INFO - Running setup.py install for mozhttpd 03:36:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Running setup.py install for mozinfo 03:36:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Running setup.py install for mozInstall 03:36:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:58 INFO - Running setup.py install for mozleak 03:36:59 INFO - Running setup.py install for mozlog 03:36:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Running setup.py install for moznetwork 03:36:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Running setup.py install for mozprocess 03:36:59 INFO - Running setup.py install for mozprofile 03:36:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Running setup.py install for mozrunner 03:36:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Running setup.py install for mozscreenshot 03:36:59 INFO - Running setup.py install for moztest 03:36:59 INFO - Running setup.py install for mozversion 03:36:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:59 INFO - Cleaning up... 03:36:59 INFO - Return code: 0 03:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36: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:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36: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:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:59 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:59 INFO - Using env: {'DISPLAY': ':0', 03:37:00 INFO - 'HOME': '/home/cltbld', 03:37:00 INFO - 'LANG': 'en_US.UTF-8', 03:37:00 INFO - 'LANGUAGE': 'en_US:en', 03:37:00 INFO - 'LOGNAME': 'cltbld', 03:37:00 INFO - 'MAIL': '/var/mail/cltbld', 03:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:00 INFO - 'MOZ_NO_REMOTE': '1', 03:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:00 INFO - 'NO_EM_RESTART': '1', 03:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:00 INFO - 'PWD': '/builds/slave/test', 03:37:00 INFO - 'SHELL': '/bin/bash', 03:37:00 INFO - 'SHLVL': '1', 03:37:00 INFO - 'TERM': 'linux', 03:37:00 INFO - 'TMOUT': '86400', 03:37:00 INFO - 'USER': 'cltbld', 03:37:00 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:00 INFO - '_': '/tools/buildbot/bin/python'} 03:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:00 INFO - Running setup.py (path:/tmp/pip-rHWkS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:00 INFO - Running setup.py (path:/tmp/pip-yNwg8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:00 INFO - Running setup.py (path:/tmp/pip-GdkzO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:00 INFO - Running setup.py (path:/tmp/pip-R0G66o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:00 INFO - Running setup.py (path:/tmp/pip-N0CGWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:00 INFO - Running setup.py (path:/tmp/pip-mt8jgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:00 INFO - Running setup.py (path:/tmp/pip-dMwVXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:00 INFO - Running setup.py (path:/tmp/pip-LLjxmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:00 INFO - Running setup.py (path:/tmp/pip-AvQRgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:00 INFO - Running setup.py (path:/tmp/pip-qiVAZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:00 INFO - Running setup.py (path:/tmp/pip-N_pM1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:00 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:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:00 INFO - Running setup.py (path:/tmp/pip-fNBQ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:01 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:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:01 INFO - Running setup.py (path:/tmp/pip-rNGrmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:01 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:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:01 INFO - Running setup.py (path:/tmp/pip-aZ5gVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:01 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:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:01 INFO - Running setup.py (path:/tmp/pip-9F9Srd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:01 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:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:01 INFO - Running setup.py (path:/tmp/pip-i6gC3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:01 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:37:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:01 INFO - Running setup.py (path:/tmp/pip-fa1wSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 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:37:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37: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:37: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:37: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:37: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:37:02 INFO - Downloading blessings-1.6.tar.gz 03:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:02 INFO - Installing collected packages: blessings 03:37:02 INFO - Running setup.py install for blessings 03:37:02 INFO - Successfully installed blessings 03:37:02 INFO - Cleaning up... 03:37:02 INFO - Return code: 0 03:37:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:02 INFO - Reading from file tmpfile_stdout 03:37:02 INFO - Current package versions: 03:37:02 INFO - argparse == 1.2.1 03:37:02 INFO - blessings == 1.6 03:37:02 INFO - blobuploader == 1.2.4 03:37:02 INFO - docopt == 0.6.1 03:37:02 INFO - functools32 == 3.2.3-2 03:37:02 INFO - jsonschema == 2.5.1 03:37:02 INFO - manifestparser == 1.1 03:37:02 INFO - mozInstall == 1.13 03:37:02 INFO - mozcrash == 1.0 03:37:02 INFO - mozdebug == 0.1 03:37:02 INFO - mozdevice == 0.51 03:37:02 INFO - mozfile == 1.2 03:37:02 INFO - mozhttpd == 0.7 03:37:02 INFO - mozinfo == 0.10 03:37:02 INFO - mozleak == 0.1 03:37:02 INFO - mozlog == 3.5 03:37:02 INFO - moznetwork == 0.27 03:37:02 INFO - mozprocess == 0.25 03:37:02 INFO - mozprofile == 0.28 03:37:02 INFO - mozrunner == 6.13 03:37:02 INFO - mozscreenshot == 0.1 03:37:02 INFO - mozsystemmonitor == 0.3 03:37:02 INFO - moztest == 0.8 03:37:02 INFO - mozversion == 1.4 03:37:02 INFO - psutil == 3.1.1 03:37:02 INFO - requests == 1.2.3 03:37:02 INFO - wsgiref == 0.1.2 03:37:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:02 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 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', '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:37:02 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:37:02 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:37:02 INFO - Using env: {'DISPLAY': ':0', 03:37:02 INFO - 'HOME': '/home/cltbld', 03:37:02 INFO - 'LANG': 'en_US.UTF-8', 03:37:02 INFO - 'LANGUAGE': 'en_US:en', 03:37:02 INFO - 'LOGNAME': 'cltbld', 03:37:02 INFO - 'MAIL': '/var/mail/cltbld', 03:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:02 INFO - 'MOZ_NO_REMOTE': '1', 03:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:02 INFO - 'NO_EM_RESTART': '1', 03:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:02 INFO - 'PWD': '/builds/slave/test', 03:37:02 INFO - 'SHELL': '/bin/bash', 03:37:02 INFO - 'SHLVL': '1', 03:37:02 INFO - 'TERM': 'linux', 03:37:02 INFO - 'TMOUT': '86400', 03:37:02 INFO - 'USER': 'cltbld', 03:37:02 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:02 INFO - '_': '/tools/buildbot/bin/python'} 03:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:37: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:37: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:37: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:37: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:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:37:04 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:37:04 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:37:04 INFO - Installing collected packages: simplejson 03:37:04 INFO - Running setup.py install for simplejson 03:37:04 INFO - building 'simplejson._speedups' extension 03:37:04 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:37:05 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:37:05 INFO - Successfully installed simplejson 03:37:05 INFO - Cleaning up... 03:37:05 INFO - Return code: 0 03:37:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b29c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', '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:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:37:05 INFO - Using env: {'DISPLAY': ':0', 03:37:05 INFO - 'HOME': '/home/cltbld', 03:37:05 INFO - 'LANG': 'en_US.UTF-8', 03:37:05 INFO - 'LANGUAGE': 'en_US:en', 03:37:05 INFO - 'LOGNAME': 'cltbld', 03:37:05 INFO - 'MAIL': '/var/mail/cltbld', 03:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:05 INFO - 'MOZ_NO_REMOTE': '1', 03:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:05 INFO - 'NO_EM_RESTART': '1', 03:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:05 INFO - 'PWD': '/builds/slave/test', 03:37:05 INFO - 'SHELL': '/bin/bash', 03:37:05 INFO - 'SHLVL': '1', 03:37:05 INFO - 'TERM': 'linux', 03:37:05 INFO - 'TMOUT': '86400', 03:37:05 INFO - 'USER': 'cltbld', 03:37:05 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:05 INFO - '_': '/tools/buildbot/bin/python'} 03:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:05 INFO - Cleaning up... 03:37:05 INFO - Return code: 0 03:37:05 INFO - Running post-action listener: _resource_record_post_action 03:37:05 INFO - Running post-action listener: _start_resource_monitoring 03:37:05 INFO - Starting resource monitoring. 03:37:05 INFO - [mozharness: 2017-09-23 10:37:05.698378Z] Finished create-virtualenv step (success) 03:37:05 INFO - [mozharness: 2017-09-23 10:37:05.698913Z] Running install step. 03:37:05 INFO - Running pre-action listener: _resource_record_pre_action 03:37:05 INFO - Running main action method: install 03:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:05 INFO - Reading from file tmpfile_stdout 03:37:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:06 INFO - Reading from file tmpfile_stdout 03:37:06 INFO - Output received: 03:37:06 INFO - Usage: mozinstall [options] installer 03:37:06 INFO - Options: 03:37:06 INFO - -h, --help show this help message and exit 03:37:06 INFO - -d DEST, --destination=DEST 03:37:06 INFO - Directory to install application into. [default: 03:37:06 INFO - "/builds/slave/test"] 03:37:06 INFO - --app=APP Application being installed. [default: firefox] 03:37:06 INFO - mkdir: /builds/slave/test/build/application 03:37:06 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:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:37:23 INFO - Reading from file tmpfile_stdout 03:37:23 INFO - Output received: 03:37:23 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:23 INFO - Running post-action listener: _resource_record_post_action 03:37:23 INFO - [mozharness: 2017-09-23 10:37:23.840334Z] Finished install step (success) 03:37:23 INFO - [mozharness: 2017-09-23 10:37:23.840673Z] Running setup-mitmproxy step. 03:37:23 INFO - Running pre-action listener: _resource_record_pre_action 03:37:23 INFO - Running main action method: setup_mitmproxy 03:37:23 INFO - Skipping: mitmproxy is not required 03:37:23 INFO - Running post-action listener: _resource_record_post_action 03:37:23 INFO - [mozharness: 2017-09-23 10:37:23.842291Z] Finished setup-mitmproxy step (success) 03:37:23 INFO - [mozharness: 2017-09-23 10:37:23.842602Z] Running run-tests step. 03:37:23 INFO - Running pre-action listener: _resource_record_pre_action 03:37:23 INFO - Running pre-action listener: _set_gcov_prefix 03:37:23 INFO - Running main action method: run_tests 03:37:23 WARNING - Try message not found. 03:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:23 INFO - Python 2.7.3 03:37:23 INFO - Return code: 0 03:37:23 INFO - grabbing minidump binary from tooltool 03:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:23 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 0x17afd60>, '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 0x17b0a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17b0ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:23 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:37:23 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:37:23 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:37:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:23 INFO - Return code: 0 03:37:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:23 INFO - ENV: RUST_BACKTRACE is now full 03:37:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:23 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:37:23 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:37:23 INFO - Using env: {'DISPLAY': ':0', 03:37:23 INFO - 'HOME': '/home/cltbld', 03:37:23 INFO - 'LANG': 'en_US.UTF-8', 03:37:23 INFO - 'LANGUAGE': 'en_US:en', 03:37:23 INFO - 'LOGNAME': 'cltbld', 03:37:23 INFO - 'MAIL': '/var/mail/cltbld', 03:37:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:23 INFO - 'MOZ_NO_REMOTE': '1', 03:37:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:23 INFO - 'NO_EM_RESTART': '1', 03:37:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:23 INFO - 'PWD': '/builds/slave/test', 03:37:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:23 INFO - 'RUST_BACKTRACE': 'full', 03:37:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:37:23 INFO - 'SHELL': '/bin/bash', 03:37:23 INFO - 'SHLVL': '1', 03:37:23 INFO - 'TERM': 'linux', 03:37:23 INFO - 'TMOUT': '86400', 03:37:23 INFO - 'USER': 'cltbld', 03:37:23 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:23 INFO - '_': '/tools/buildbot/bin/python'} 03:37:23 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:37:24 INFO - mozversion application_buildid: 20170923093626 03:37:24 INFO - mozversion application_changeset: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 03:37:24 INFO - mozversion application_display_name: Nightly 03:37:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:24 INFO - mozversion application_name: Firefox 03:37:24 INFO - mozversion application_remotingname: firefox 03:37:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:37:24 INFO - mozversion application_vendor: Mozilla 03:37:24 INFO - mozversion application_version: 58.0a1 03:37:24 INFO - mozversion platform_buildid: 20170923093626 03:37:24 INFO - mozversion platform_changeset: 8c3a1558322331c1fab9d1d2d7a94ef69f2a9212 03:37:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:37:24 INFO - mozversion platform_version: 58.0a1 03:37:24 INFO - using testdate: 1506163044 03:37:24 INFO - actual date: 1506163044 03:37:24 INFO - starting webserver on 'localhost:52678' 03:37:24 INFO - SUITE-START | Running 2 tests 03:37:24 INFO - TEST-START | dromaeo_css 03:37:24 INFO - Initialising browser for dromaeo_css test... 03:37:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52678/getInfo.html -profile /tmp/tmpPimx2N/profile 03:37:24 INFO - TEST-INFO | started process 7324 (/builds/slave/test/build/application/firefox/firefox http://localhost:52678/getInfo.html) 03:37:29 INFO - TEST-INFO | 7324: exit 0 03:37:29 INFO - Browser initialized. 03:37:29 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:29 INFO - Using env: {'DISPLAY': ':0', 03:37:29 INFO - 'HOME': '/home/cltbld', 03:37:29 INFO - 'JSGC_DISABLE_POISONING': '1', 03:37:29 INFO - 'LANG': 'en_US.UTF-8', 03:37:29 INFO - 'LANGUAGE': 'en_US:en', 03:37:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:37:29 INFO - 'LOGNAME': 'cltbld', 03:37:29 INFO - 'MAIL': '/var/mail/cltbld', 03:37:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:29 INFO - 'MOZ_CRASHREPORTER': '1', 03:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:37:29 INFO - 'MOZ_NO_REMOTE': '1', 03:37:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:29 INFO - 'NO_EM_RESTART': '1', 03:37:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:29 INFO - 'PWD': '/builds/slave/test', 03:37:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:29 INFO - 'RUST_BACKTRACE': 'full', 03:37:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:37:29 INFO - 'SHELL': '/bin/bash', 03:37:29 INFO - 'SHLVL': '1', 03:37:29 INFO - 'STYLO_FORCE_DISABLED': '1', 03:37:29 INFO - 'TERM': 'linux', 03:37:29 INFO - 'TMOUT': '86400', 03:37:29 INFO - 'USER': 'cltbld', 03:37:29 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:29 INFO - '_': '/tools/buildbot/bin/python'} 03:37:29 INFO - TEST-INFO | started process 7560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPimx2N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:30 INFO - PID 7560 | 03:37:30 INFO - PID 7560 | (/builds/slave/test/build/application/firefox/firefox:7609): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:37:30 INFO - PID 7560 | 03:37:41 INFO - PID 7560 | RSS: Main: 152113152 03:37:41 INFO - PID 7560 | 03:40:37 INFO - PID 7560 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52678/tests/dromaeo/cssquery-ext.html) 03:40:38 INFO - PID 7560 | RSS: Main: 153751552 03:40:38 INFO - PID 7560 | 03:43:40 INFO - PID 7560 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-ext.html (next: http://localhost:52678/tests/dromaeo/cssquery-jquery.html) 03:43:41 INFO - PID 7560 | RSS: Main: 153165824 03:43:41 INFO - PID 7560 | 03:46:42 INFO - PID 7560 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52678/tests/dromaeo/cssquery-mootools.html) 03:46:43 INFO - PID 7560 | RSS: Main: 155242496 03:46:43 INFO - PID 7560 | 03:49:45 INFO - PID 7560 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52678/tests/dromaeo/cssquery-prototype.html) 03:49:45 INFO - PID 7560 | RSS: Main: 153907200 03:49:45 INFO - PID 7560 | 03:52:48 INFO - PID 7560 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52678/tests/dromaeo/cssquery-yui.html) 03:52:49 INFO - PID 7560 | RSS: Main: 153305088 03:52:49 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | Cycle 1(1): loaded http://localhost:52678/tests/dromaeo/cssquery-yui.html (next: http://localhost:52678/tests/dromaeo/cssquery-dojo.html) 03:55:51 INFO - PID 7560 | RSS: Main: 157655040 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | __start_tp_report 03:55:51 INFO - PID 7560 | _x_x_mozilla_page_load 03:55:51 INFO - PID 7560 | _x_x_mozilla_page_load_details 03:55:51 INFO - PID 7560 | |i|pagename|runs| 03:55:51 INFO - PID 7560 | |0;dojo.html;3131.6711745266743;3161.367726454709;3167.7465802735783;3176.825274609897;3203.07110937828;6097.146399504062;6240.43836054755;6273.153124328214;6276.905846412302;6284.842878928029;6171.105189747484;6232.2832874219475;6334.778282760104;6352.015437607167;6382.457491113261;5705.5435565154685;5797.043487824525;5799.18811366409;5816.418358164171;5857.092150716646;110.6850839078079;5627;5743.483086522212;5819.068948968166;5821.243238379005;5702.572307076985;5703.714814259291;5761.827145185651;5767.077267637158;5778.248827652399;5649;5651.011073062239;5732.140178973145;5754.769809207627;5761.0494268445655;5626.240457538262;5682.374938756733;5747.3677895431465;5761.3950535194035;5774.220480235156;6096.908546371808;6192.9380706192815;6203.31763506014;6277.7802776903045;6279.120923070774;6450.8064758057335;6614.305497922697;6654.6672666366485;6672.599644021374;6749.966250168767;6647.069410282565;6651.102101216371;6659.9001014984815;6669.633170175638;6674.199096108498;6157.692115394212;6263.091851681481;6271.686415679198;6289.905651415233;6297;6843.692033858489;6855.622940738208;6927.58434493932;6929.549579277331;6938.618375989268;6503.2521260054755;6534.705938232791;6535.411812936859;6580.638064906476;6642.568233064835;6712.261651218362;6718.32816718334;6731.124953755981;6734.124563806772;6738.932610673928;6623.172103487064;6637.502187335969;6691.933080669131;6703.497237707192;6729.192496900403;6686.498512611476;6698.765543206062;6757.189137303555;6765.646870625895;6774.593524388552;5198.92201616976;5286.788528458896;5308.761105750174;5326.92009619856;5402.756875940592;4669.60308373792;4683.227267500824;4738.076075165379;4744.739039352799;4760.071786001697;5713.228714123623;5803.8549036274435;5875.970620146957;5884.705764711747;5888.234529511222;6704.061431399608;6709;6773.153355830521;6784;6787.321267873272;5743.511801496836;5811.564132690065;5832.708364581754;5869.501092407193;5884.146798714162;5814.215080964101;5875.177475153482;5888.352281249059;5891.027980383189;5894.646321220741;6507.739690412331;6585.111010013683;6587.143671322698;6600.2409722882485;6638.933610663928;6577.901331480031;6637.800865974028;6645.435138013227;6657.467402607683;6657.933420665925;6563.310852360624;6568.7372505099265;6572.80281591553;6573.5398522103;6574.539782215199;6532.608043517214;6538.378854008862;6637.701303441453;6642.800715978528;6647.767328143492;6696.59820410777;6705.865882682417;6707.5975441473665;6799.184097908283;6817.2501024888215;6305.1172835803945;6450.871097557815;6452.419282264619;6521.64130972801;6538.803835884931;6375.234971803413;6413;6437.710303036468;6442.742290308335;6451.096846441408;6412.61524308543;6451.483881289391;6462.353764623688;6471.546991710535;6477.093206950936;6492.837679058061;6505.60966342021;6600.339966003361;6611.206655201407;6617.338266173537;6257.9687101564205;6280.340564240872;6335.429811317003;6354.110424540476;6365.96817015912 03:55:51 INFO - PID 7560 | |1;ext.html;738.162185918982;763.7021561590977;765.7664412354234;768.2970082374626;770.6994272233826;37884.810575947115;41477.79261103694;41539.584604153984;41657;42002.36996445048;38228.23543529128;38338.233235335276;38345.808270958674;38370.232595348076;38417.42373864394;7220.530665506738;7303.379212766895;7881.487703299296;8124.309433698143;8145.796355091141;8014.879776803353;8070.596470176468;8122.675092996273;8133.877991830127;8136.389770767187;8106;8145.226203510657;8148.959255203746;8179.918200818005;8180;8089.069756977935;8096.230858068474;8109.7161599343735;8116.2695357418115;8118.14759450258;8003.1996800320085;8079.798005049862;8080.676772929076;8083.272505474477;8092.757217283491;37838.4324235134;38049.809750951346;38053.429198562044;38161.23677526434;38242.426363604565;3546.989108104178;3561.6794488495902;3570.62508436613;3579.7494175407733;3596.1549035976523;31493;31554.684453155405;31574.842125789222;31640;31711;5124.666896651743;5173.27574139617;5199.376074871002;5233.581313494949;5245.213218017289;185425;185655;185900;186937.99999999863;187232;43073.78463107665;43931.78034109809;49436.75281623569;49518;50230.748846255534;52702.209466858025;52800;52856.62145203475;52950.20574691382;52968;16237.756433653505;16287.267072981744;16334.75497867533;16381.42665006743;16409.507714768577;13271.73456530864;13332.066755327034;13343.06598538093;13351.866481335257;13478.932605337106;14221.217833019076;14328;14380.280985950661;14409.06341087826;14607.707845843024;5959.970200148971;6016.879662406727;6054.516643422302;6087.908681369783;6095.35998720128;1002.2483137646765;1026.9026583930215;1031.654395777408;1038.683201623512;1045.10643399892;23154.65268020981;23157.88421057884;23198.42003949881;23291;23396.064157433513;1130.1467392118898;1133.3766428464312;1133.4049623947494;1141.8116010858282;1143.4625725908809;12085.637430877088;12155.392230388445;12299.831516005965;12352;12358.073144514017;209468;214794;214945;215635;216995;51928.48071519237;52276.21585676218;52431.73784131055;52716;52971;1433.7347590695754;1461.335092532895;1477.9187144707143;1487.1820498725874;1487.7396455620224;22813.885930570905;22819.315420537412;22822.42943926415;22859.542809144055;22993.88503057474;34172.31655366829;34208.486872697424;34265;34271;34283.31433371269;193223;193259;194374;194510;194679;33559.32881342409;34349.82825085858;35085.47371789476;35472.46791298081;35600.10999725028;44855.32717009182;46100;46415.76792116153;46527.53472465232;46543.301850471595;32884.67115328816;33075.83462082674;33191;33198;33222;33208.833955830065;33228.50157247692;33253.66746332506;33378.666213338525;33783.4932476018;36864.81567592145;37067.25865482729;37135.6286437143;37432.81283593673;37560.24879502449;32330.191745206557;32353.35293294168;32466.513002304513;32747.34505309833;33002.83498582492;24654.63018054695;24708.752912470645;24822.00711971501;25010.499790004462;25233.243002709947 03:55:51 INFO - PID 7560 | |2;jquery.html;589.6815719511465;595.4492094812298;596.2457491273537;605.7183409714482;631.5736877607615;22181.556368872614;23138.190163344287;23143.421414464625;23160.30519084428;23230;23178.42053948652;25615.871920640417;25987;25994.740052599467;26036.73963260367;6638.933610663904;6812.829679258033;6823.69293381799;6880.483963702717;6886.931130688704;6655.500837437212;6789.5926244425245;6994.2656021117555;7259.528130671516;7326.9267307327045;7360.26397360265;7360.963195184044;7363.042804435443;7371.778846634609;7377.741779037735;6940.097787287671;7250.16623088341;7257.201707812136;7366.15289241736;7377.262273772633;7031.015657807911;7093.290670932917;7096.970939213785;7098.432125429953;7104.21853596104;30380;31606;31618.683813161802;31715.52426713601;31735.52396714051;2107.3677896630948;2132.029926383492;2132.5734853029458;2141.1649456711893;2143.6677315016195;20514.487137821525;21718.13127474899;21748.13007479699;21841.890790546106;21846.890765546228;2563.487302539481;2607.674040744907;2671.238696971354;2674.585439256899;2677.397585543257;125666.37166814199;127373;131872.34063829618;140180;146954;20876.37370878876;21175.36473905785;22186.44533886666;22267.888660556593;22513.549729005656;42999;43015.784921075196;43075;43139.35290970638;43149.35275970863;10825.67522974312;10917.945410272898;10919.617813376493;10939.617113401151;11187.105031597453;8838.39513351521;8841.425307355;8889.688860889837;8930.240929520933;8961.910380896237;11190.097683393842;11330.206885517935;11580.710482237842;11627.6511704649;11661;3882.8446862125766;3936.2127574485216;4134.565870583546;4366.126774645084;4611.377464042378;942.8397172480695;954.3844220477753;954.746992047108;960.3901522533241;975.9072888075622;18448.63102737938;18812.623747525246;18925.62148757017;19203.135858886384;19407.417777466697;1019.3374306700556;1026.7689769801884;1035.409816404642;1041.6874937518714;1043.0768769638923;10303;10351.792964140675;10513.526891289757;10687.732806679895;10785.245032847626;438539;453068;456756;457812;461270;101349;105222;105361.47319263355;106355;106633;1067.7010437077631;1078.8651418572679;1115.9163062770324;1118.3345909184022;1182.5506307603227;20789.376318710463;20794.376168714964;20832.687509687064;20918.372448826558;20964.266250681154;54068;56480;56917;57901;58306;70804.64597676978;71623;72310.63844680953;72372;72831;20321.49196270105;20643.690344645143;20678.896605516875;20779.68830467514;20804.271850485162;23189.188378406674;23571.29286121419;23683.64474532849;23812.88093559521;23909;18683;18695.719564206818;19117.617647647246;19141;19141.712874306617;16499.917500412903;16826.57933551671;17216.397426090025;17585.560360991076;17718.11409429549;18366.357177498725;19230.615387692447;19395.806041939966;19445.416637500897;19621.72458790174;20146.496337591678;20236.494087647927;20299.79700203038;20313.79686203119;20396.184152633727;18750.624987500447;18825.34111306098;18962.52593685169;19284.517887052934;19298.22807087701 03:55:51 INFO - PID 7560 | |3;mootools.html;1284.3385656386959;1351.905366624336;1358.986410135899;1360.061557525308;1364.4951367993845;15228.54314370568;15856.603584910368;15861.286242119118;15866.286017129229;15881.602959926007;15559.92220038901;15669;15693.136877471734;15693.21533923305;15697;2694.393761403683;2781.3463835998523;2786.763125134356;2787.0941943868224;2787.8327300362043;2719.279390961387;2741.2735625059377;2742.725727427261;2746.258510202254;2750.601162831388;2744.1493137127454;2857.042890631641;2861.971380286191;2862.8854845806245;2863.9140825775157;2862.541993281086;2863.642044744407;2866.0398766413173;2884.4519541287086;2888.1046875468674;2550.2604244768995;2830.7169283071735;2836.489431902257;2837.120492647286;2840.5597132444504;15320.92753507255;15520.379184832593;15547.30037148331;15562.610934726723;15570.37718491259;8048.597570121529;8358.498490090615;8359.8328033439;8360.372972027062;8368.83262334756;5508.906615486129;5526.115821468586;5679.4036626154075;5723.198752174699;5748.45389687979;1905.4188472515877;1910.2645481489587;1927.3447028010403;1940.8544359173118;1984.7519060117486;27743.306417339525;27962.440751185066;27971.86014069937;27973.720262797317;28059.15822525307;6639.933600664028;6707.899381509281;6720.596764194164;6823.829404264933;6847.965760171167;17460.301587936596;17610.119494025246;17623.911880440774;17658.1170941455;17678.116094195495;8037.8392432152195;8165.101838797727;8189.754307370788;8200.630971606291;8250.298724608356;7382.446316526282;7581.279778421152;7587.203343648837;7653.387728981668;7655.119661238918;5082.390113186368;5203.063448579292;5230.137027390438;5289.2330612061805;5293.311869456946;1473.4400927647425;1520.1335238913714;1540.4839378808;1573.6065983504125;1604.8154462236992;875.146731936357;890.7194233816327;894.088030209183;901.0898992018109;914.3416739947228;8814.471131732116;8894.822103558023;8917.821643567093;8952.23905967987;9110.954445227731;983.2379905573238;1006.1296978113879;1009.3489699144011;1009.9646512372032;1011.4285428732743;5324.121519949243;5398.379186393537;5488.25908502355;5675.744591493392;5711.514521265739;21606.243781467572;21752.782472175077;22246;22742.886285568467;22856;22349.664755028687;22518;22670.65994010091;22686.773132268798;22796;10329;11708.590199342982;11829.17195796286;11837.88162118385;11843.88156118445;8115.715949941724;8363.163683631832;8432.325413966746;8461.365397595082;8481.109483504144;19151.13819878081;19369.51576210606;19629.70555441641;19802.70295945533;19933;19464.1241144146;19863.801361986196;19893.701594475806;20277.49306267355;20912.268070617454;11196.104311655212;11238.606648767254;11397.202195846543;11403.144764142557;11405.54377824911;14196.645083872985;14495.565133046026;14501.927490362481;14516.274186290855;14517;11530.250533715282;11566.30602163873;11579.421028948687;11739.178257521891;11800.82298765502;11505.48225329879;11574.47914843851;11666.241694290184;11723.237989530653;11833.230839995373;9930.553125109243;10141.138003269509;10142.645007424704;10144.695659130239;10169.644062457779;7365.447591430557;7377.668004939898;7417.851642967218;7461.067366579177;7467.141278752796;7561.130469996021;7562.924370756222;7588.241175882367;7617.428692847948;7717 03:55:51 INFO - PID 7560 | |4;prototype.html;518.862501437119;529.7907326605992;545.4490964126232;546.2652732075358;555.1949672974185;6222.937770622292;6244.281907580618;6245.437910588057;6326.4011349955335;6344.1752572165615;6195.845103872405;6214.285357183925;6219.533534984872;6251.187345645071;6313.526485513582;5156.355455568054;5183.974080129594;5228.2680424740565;5228.660137091077;5237.947620523803;4974.850754477371;5097.133487307148;5129.461406552315;5196.480351964792;5208.114620514521;5064.797408103672;5071.1632580624155;5127.846304552078;5145.073886700392;5149.433562308143;5069.239614057884;5081.618878584121;5091.261767043758;5098.5921126309995;5125.871853203663;4698.624110071186;4703.8249181802485;4706.247000479941;4710.034442939189;4710.882227944295;6121.571489995702;6129.1419201311855;6173.135760993465;6183.81448556544;6211.130441738161;5791.333996590404;5841.970790146022;5883.441073098049;5890.70546472679;5918.940810591925;6485.967570162119;6544.70548825304;6556.508261880331;6559.442447391977;6601.669916504204;4886.560209581119;5070.569001634865;5125.846224613268;5151.613628977804;5184.481551844823;6651.800445986628;6732.1921369435495;6758.256591774901;6780.932190678129;6849.1096157499205;5322.494363035506;5330.680159190461;5373.892522149535;5384.273123128328;5415.83752487426;5404.513593776579;5409.675419474844;5446.91829622556;5456.563474921997;5468.507834294933;5807.274090738658;5836.556431705314;5844.298684157929;5905.704714764244;5948.464638182498;6565.573237739532;6579.868402631921;6599.373059559334;6620.271770105284;6656.467482601381;1886.122952826942;1895.5924476237676;1898.9715154272697;1908;1915.7126431035178;1329.9867001329862;1396.8882489400823;1397.3921344215298;1408.8802451791507;1421.289355322339;5678.346990096109;5728.455796699307;5731.770729170787;5745.971270143623;5789.3921138279875;6534.640594767334;6580.76967306142;6592.274849766522;6617.735290588323;6647.767328143492;5704.1443783432815;5732.71336433185;5746;5771.88456230873;5775.740091695884;3490.528778614905;3517.43721004638;3518.419460788992;3530.717542596586;3541.1678255609913;6561;6580.76967306142;6604.834879127964;6638.302978187221;6649.667516624149;6685.866282674319;6716.328367163244;6782.762603308861;6870.3473170048765;6871.14110736158;6578.730338033371;6602.537822352389;6616.470682345401;6636.435902948207;6643.402093811484;6618.139641846529;6620.238672552526;6621.735130594722;6659.367360100783;6661.3338666132995;6491.967540162269;6497.350264973465;6543.509236807354;6560.278369379269;6629.171353580802;6364.872702546016;6450.741970321323;6469.5794773339585;6533.477321814338;6576.2708475981935;5330.866728331667;5343.866403339947;5364.4099149094345;5368.919466208088;5389.56883449331;6406.87186256263;6542.771003014872;6590.176227971504;6642.202935647753;6646.371638948489;6107;6224.595401298901;6368.808935731936;6400.55196136266;6421.5825971311715;6315.494760419064;6386.594949111188;6402.167718196604;6414.358564143548;6451.1936007999;6191.907121393273;6227.688615569113;6232.220972378453;6296.181496405621;6332.366763323631;6297;6342.841428964312;6360.713767880549;6430.356964303533;6459.321771214143;6114.785982490592;6144.201253836973;6211.192544969125;6217.191765070512;6233.688315584112 03:55:51 INFO - PID 7560 | |5;yui.html;898.5866501409351;908.110052148894;936.6206686292049;940.0364626258084;944.8724422203005;19041.71437428438;20047.498812529695;20155.899220503914;20183.09176087076;20183.899080504594;17857.10714464278;17935.461936141935;18134.274629014824;18686;18953.810461895377;971.1550950672906;990.1534188269035;993.2500961773886;993.3592832622954;994.6866736977829;966.1063516247478;984.8621193032981;1006.9848952265685;1007.8337074382719;1011.716719318592;1069.4332004037872;1077.8113830079744;1079.9028087472127;1079.9730006749814;1080.076534562949;987.2792861211284;1020.5611587017579;1057.3919996002292;1059.1050562274866;1065.8347956066823;754.8716718157872;755.3164386230416;756.406221116421;757.1066141952493;760.2739383888373;20785.27251546204;21004.264850730306;21009.68485472719;21047.158113675436;21095.894520527298;22286.88856555707;22948.196813111626;23138.190163344203;23202.883985580134;23203.419914502105;17117.887337323158;17508.21213045416;17573.12134393288;17602.11989400525;17616.295348186057;3767.811609419518;3788.6021967693546;3793.6775374093236;3794.051487128218;3800.5819359870393;138618;138887;141098.29450852782;141209;142758.28620856933;15191.164485953157;15448.459303924308;15484.30320635574;15515.689686206213;15530.301136448887;27553.311167220578;27953.440931181263;28286.292842679097;28575;28646.427071458453;8573.27127194183;8773.122687731176;8782.121787821166;8782.2096011358;8786.956065219632;4394.406755088022;4419.513853476179;4505.7521836298665;4554.339620754972;4598.609118224921;5592.077307244259;5680.233168522279;5685.289338832646;5698.17376480408;5699.74351154199;933.0855761353776;959.5058544849409;975;975.0541974284932;975.380633297861;660.1945626335862;680.3774546290089;685.1230425055837;688.5214775730819;690.5304393012799;11137.665870023913;11784;11847.466863991142;11879.76240475203;12367.010639148846;660.2605082307846;664.8271449423088;666.8066260784415;672.6670298202421;677.5325025732229;5357.848062666545;5366.221897824794;5391.865203369869;5418.45815418455;5523.861903452365;123940.38029809794;125095;125885;127803;128114.35942820227;107707;108844;109219.45390273156;110765.44617277023;114360;91792.54103729573;92158.53920730487;94689.52655236817;95233.0476695238;95652;9965.551550180115;10040.899591004289;10173.694789156338;10290.176785856964;10363.689089327332;42477.78761106174;43406.56593434152;44412.11175776531;44841.551584483735;45298.32052519281;57116.714416427654;57254.42745572491;57652;59191.40808592031;60239.09641355296;14802.407903683732;15071.924640376728;15136.091834489966;15216;15305.693886121993;16858.15709214559;16979.830201697823;17049.40327088546;17098.316067357166;17183.226754796313;14736.705265894836;14806.851931480547;14816.555503334917;14829;15011.32449039774;15413.922930385277;15785.526434206991;15859.52421427359;15876.364945402516;15902.204889755698;14625.85374146245;14955.551333460013;14973;15036.473723419627;15144.318505667492;12432.12975091735;12565.994720422526;12727.872721272668;12889.226646401246;12903.290319032543;11884.168108232341;12035.45840437165;12040.277583345027;12125.878741212475;12467.189632673848 03:55:51 INFO - PID 7560 | __end_tp_report 03:55:51 INFO - PID 7560 | __start_cc_report 03:55:51 INFO - PID 7560 | _x_x_mozilla_cycle_collect,297 03:55:51 INFO - PID 7560 | __end_cc_report 03:55:51 INFO - PID 7560 | __startTimestamp1506164151405__endTimestamp 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | ------- Summary: start ------- 03:55:51 INFO - PID 7560 | Number of tests: 6 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | [#0] dojo.html Cycles:165 Average:6130.37 Median:6412.62 stddev:860.67 (13.4%) stddev-sans-first:830.53 03:55:51 INFO - PID 7560 | Values: 3131.7 3161.4 3167.7 3176.8 3203.1 6097.1 6240.4 6273.2 6276.9 6284.8 6171.1 6232.3 6334.8 6352.0 6382.5 5705.5 5797.0 5799.2 5816.4 5857.1 110.7 5627.0 5743.5 5819.1 5821.2 5702.6 5703.7 5761.8 5767.1 5778.2 5649.0 5651.0 5732.1 5754.8 5761.0 5626.2 5682.4 5747.4 5761.4 5774.2 6096.9 6192.9 6203.3 6277.8 6279.1 6450.8 6614.3 6654.7 6672.6 6750.0 6647.1 6651.1 6659.9 6669.6 6674.2 6157.7 6263.1 6271.7 6289.9 6297.0 6843.7 6855.6 6927.6 6929.5 6938.6 6503.3 6534.7 6535.4 6580.6 6642.6 6712.3 6718.3 6731.1 6734.1 6738.9 6623.2 6637.5 6691.9 6703.5 6729.2 6686.5 6698.8 6757.2 6765.6 6774.6 5198.9 5286.8 5308.8 5326.9 5402.8 4669.6 4683.2 4738.1 4744.7 4760.1 5713.2 5803.9 5876.0 5884.7 5888.2 6704.1 6709.0 6773.2 6784.0 6787.3 5743.5 5811.6 5832.7 5869.5 5884.1 5814.2 5875.2 5888.4 5891.0 5894.6 6507.7 6585.1 6587.1 6600.2 6638.9 6577.9 6637.8 6645.4 6657.5 6657.9 6563.3 6568.7 6572.8 6573.5 6574.5 6532.6 6538.4 6637.7 6642.8 6647.8 6696.6 6705.9 6707.6 6799.2 6817.3 6305.1 6450.9 6452.4 6521.6 6538.8 6375.2 6413.0 6437.7 6442.7 6451.1 6412.6 6451.5 6462.4 6471.5 6477.1 6492.8 6505.6 6600.3 6611.2 6617.3 6258.0 6280.3 6335.4 6354.1 6366.0 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | [#1] ext.html Cycles:180 Average:37060.39 Median:34316.57 stddev:51315.75 (149.5%) stddev-sans-first:51387.22 03:55:51 INFO - PID 7560 | Values: 738.2 763.7 765.8 768.3 770.7 37884.8 41477.8 41539.6 41657.0 42002.4 38228.2 38338.2 38345.8 38370.2 38417.4 7220.5 7303.4 7881.5 8124.3 8145.8 8014.9 8070.6 8122.7 8133.9 8136.4 8106.0 8145.2 8149.0 8179.9 8180.0 8089.1 8096.2 8109.7 8116.3 8118.1 8003.2 8079.8 8080.7 8083.3 8092.8 37838.4 38049.8 38053.4 38161.2 38242.4 3547.0 3561.7 3570.6 3579.7 3596.2 31493.0 31554.7 31574.8 31640.0 31711.0 5124.7 5173.3 5199.4 5233.6 5245.2 185425.0 185655.0 185900.0 186938.0 187232.0 43073.8 43931.8 49436.8 49518.0 50230.7 52702.2 52800.0 52856.6 52950.2 52968.0 16237.8 16287.3 16334.8 16381.4 16409.5 13271.7 13332.1 13343.1 13351.9 13478.9 14221.2 14328.0 14380.3 14409.1 14607.7 5960.0 6016.9 6054.5 6087.9 6095.4 1002.2 1026.9 1031.7 1038.7 1045.1 23154.7 23157.9 23198.4 23291.0 23396.1 1130.1 1133.4 1133.4 1141.8 1143.5 12085.6 12155.4 12299.8 12352.0 12358.1 209468.0 214794.0 214945.0 215635.0 216995.0 51928.5 52276.2 52431.7 52716.0 52971.0 1433.7 1461.3 1477.9 1487.2 1487.7 22813.9 22819.3 22822.4 22859.5 22993.9 34172.3 34208.5 34265.0 34271.0 34283.3 193223.0 193259.0 194374.0 194510.0 194679.0 33559.3 34349.8 35085.5 35472.5 35600.1 44855.3 46100.0 46415.8 46527.5 46543.3 32884.7 33075.8 33191.0 33198.0 33222.0 33208.8 33228.5 33253.7 33378.7 33783.5 36864.8 37067.3 37135.6 37432.8 37560.2 32330.2 32353.4 32466.5 32747.3 33002.8 24654.6 24708.8 24822.0 25010.5 25233.2 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | [#2] jquery.html Cycles:180 Average:34903.46 Median:22825.87 stddev:76347.36 (334.5%) stddev-sans-first:76518.06 03:55:51 INFO - PID 7560 | Values: 589.7 595.4 596.2 605.7 631.6 22181.6 23138.2 23143.4 23160.3 23230.0 23178.4 25615.9 25987.0 25994.7 26036.7 6638.9 6812.8 6823.7 6880.5 6886.9 6655.5 6789.6 6994.3 7259.5 7326.9 7360.3 7361.0 7363.0 7371.8 7377.7 6940.1 7250.2 7257.2 7366.2 7377.3 7031.0 7093.3 7097.0 7098.4 7104.2 30380.0 31606.0 31618.7 31715.5 31735.5 2107.4 2132.0 2132.6 2141.2 2143.7 20514.5 21718.1 21748.1 21841.9 21846.9 2563.5 2607.7 2671.2 2674.6 2677.4 125666.4 127373.0 131872.3 140180.0 146954.0 20876.4 21175.4 22186.4 22267.9 22513.5 42999.0 43015.8 43075.0 43139.4 43149.4 10825.7 10917.9 10919.6 10939.6 11187.1 8838.4 8841.4 8889.7 8930.2 8961.9 11190.1 11330.2 11580.7 11627.7 11661.0 3882.8 3936.2 4134.6 4366.1 4611.4 942.8 954.4 954.7 960.4 975.9 18448.6 18812.6 18925.6 19203.1 19407.4 1019.3 1026.8 1035.4 1041.7 1043.1 10303.0 10351.8 10513.5 10687.7 10785.2 438539.0 453068.0 456756.0 457812.0 461270.0 101349.0 105222.0 105361.5 106355.0 106633.0 1067.7 1078.9 1115.9 1118.3 1182.6 20789.4 20794.4 20832.7 20918.4 20964.3 54068.0 56480.0 56917.0 57901.0 58306.0 70804.6 71623.0 72310.6 72372.0 72831.0 20321.5 20643.7 20678.9 20779.7 20804.3 23189.2 23571.3 23683.6 23812.9 23909.0 18683.0 18695.7 19117.6 19141.0 19141.7 16499.9 16826.6 17216.4 17585.6 17718.1 18366.4 19230.6 19395.8 19445.4 19621.7 20146.5 20236.5 20299.8 20313.8 20396.2 18750.6 18825.3 18962.5 19284.5 19298.2 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | [#3] mootools.html Cycles:180 Average:9663.01 Median:2730.28 stddev:6969.60 (255.3%) stddev-sans-first:6960.72 03:55:51 INFO - PID 7560 | Values: 1284.3 1351.9 1359.0 1360.1 1364.5 15228.5 15856.6 15861.3 15866.3 15881.6 15559.9 15669.0 15693.1 15693.2 15697.0 2694.4 2781.3 2786.8 2787.1 2787.8 2719.3 2741.3 2742.7 2746.3 2750.6 2744.1 2857.0 2862.0 2862.9 2863.9 2862.5 2863.6 2866.0 2884.5 2888.1 2550.3 2830.7 2836.5 2837.1 2840.6 15320.9 15520.4 15547.3 15562.6 15570.4 8048.6 8358.5 8359.8 8360.4 8368.8 5508.9 5526.1 5679.4 5723.2 5748.5 1905.4 1910.3 1927.3 1940.9 1984.8 27743.3 27962.4 27971.9 27973.7 28059.2 6639.9 6707.9 6720.6 6823.8 6848.0 17460.3 17610.1 17623.9 17658.1 17678.1 8037.8 8165.1 8189.8 8200.6 8250.3 7382.4 7581.3 7587.2 7653.4 7655.1 5082.4 5203.1 5230.1 5289.2 5293.3 1473.4 1520.1 1540.5 1573.6 1604.8 875.1 890.7 894.1 901.1 914.3 8814.5 8894.8 8917.8 8952.2 9111.0 983.2 1006.1 1009.3 1010.0 1011.4 5324.1 5398.4 5488.3 5675.7 5711.5 21606.2 21752.8 22246.0 22742.9 22856.0 22349.7 22518.0 22670.7 22686.8 22796.0 10329.0 11708.6 11829.2 11837.9 11843.9 8115.7 8363.2 8432.3 8461.4 8481.1 19151.1 19369.5 19629.7 19802.7 19933.0 19464.1 19863.8 19893.7 20277.5 20912.3 11196.1 11238.6 11397.2 11403.1 11405.5 14196.6 14495.6 14501.9 14516.3 14517.0 11530.3 11566.3 11579.4 11739.2 11800.8 11505.5 11574.5 11666.2 11723.2 11833.2 9930.6 10141.1 10142.6 10144.7 10169.6 7365.4 7377.7 7417.9 7461.1 7467.1 7561.1 7562.9 7588.2 7617.4 7717.0 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | [#4] prototype.html Cycles:180 Average:5555.07 Median:6178.48 stddev:1482.37 (24.0%) stddev-sans-first:1437.52 03:55:51 INFO - PID 7560 | Values: 518.9 529.8 545.4 546.3 555.2 6222.9 6244.3 6245.4 6326.4 6344.2 6195.8 6214.3 6219.5 6251.2 6313.5 5156.4 5184.0 5228.3 5228.7 5237.9 4974.9 5097.1 5129.5 5196.5 5208.1 5064.8 5071.2 5127.8 5145.1 5149.4 5069.2 5081.6 5091.3 5098.6 5125.9 4698.6 4703.8 4706.2 4710.0 4710.9 6121.6 6129.1 6173.1 6183.8 6211.1 5791.3 5842.0 5883.4 5890.7 5918.9 6486.0 6544.7 6556.5 6559.4 6601.7 4886.6 5070.6 5125.8 5151.6 5184.5 6651.8 6732.2 6758.3 6780.9 6849.1 5322.5 5330.7 5373.9 5384.3 5415.8 5404.5 5409.7 5446.9 5456.6 5468.5 5807.3 5836.6 5844.3 5905.7 5948.5 6565.6 6579.9 6599.4 6620.3 6656.5 1886.1 1895.6 1899.0 1908.0 1915.7 1330.0 1396.9 1397.4 1408.9 1421.3 5678.3 5728.5 5731.8 5746.0 5789.4 6534.6 6580.8 6592.3 6617.7 6647.8 5704.1 5732.7 5746.0 5771.9 5775.7 3490.5 3517.4 3518.4 3530.7 3541.2 6561.0 6580.8 6604.8 6638.3 6649.7 6685.9 6716.3 6782.8 6870.3 6871.1 6578.7 6602.5 6616.5 6636.4 6643.4 6618.1 6620.2 6621.7 6659.4 6661.3 6492.0 6497.4 6543.5 6560.3 6629.2 6364.9 6450.7 6469.6 6533.5 6576.3 5330.9 5343.9 5364.4 5368.9 5389.6 6406.9 6542.8 6590.2 6642.2 6646.4 6107.0 6224.6 6368.8 6400.6 6421.6 6315.5 6386.6 6402.2 6414.4 6451.2 6191.9 6227.7 6232.2 6296.2 6332.4 6297.0 6342.8 6360.7 6430.4 6459.3 6114.8 6144.2 6211.2 6217.2 6233.7 03:55:51 INFO - PID 7560 | 03:55:51 INFO - PID 7560 | [#5] yui.html Cycles:180 Average:24364.56 Median:20484.59 stddev:35684.68 (174.2%) stddev-sans-first:35741.29 03:55:51 INFO - PID 7560 | Values: 898.6 908.1 936.6 940.0 944.9 19041.7 20047.5 20155.9 20183.1 20183.9 17857.1 17935.5 18134.3 18686.0 18953.8 971.2 990.2 993.3 993.4 994.7 966.1 984.9 1007.0 1007.8 1011.7 1069.4 1077.8 1079.9 1080.0 1080.1 987.3 1020.6 1057.4 1059.1 1065.8 754.9 755.3 756.4 757.1 760.3 20785.3 21004.3 21009.7 21047.2 21095.9 22286.9 22948.2 23138.2 23202.9 23203.4 17117.9 17508.2 17573.1 17602.1 17616.3 3767.8 3788.6 3793.7 3794.1 3800.6 138618.0 138887.0 141098.3 141209.0 142758.3 15191.2 15448.5 15484.3 15515.7 15530.3 27553.3 27953.4 28286.3 28575.0 28646.4 8573.3 8773.1 8782.1 8782.2 8787.0 4394.4 4419.5 4505.8 4554.3 4598.6 5592.1 5680.2 5685.3 5698.2 5699.7 933.1 959.5 975.0 975.1 975.4 660.2 680.4 685.1 688.5 690.5 11137.7 11784.0 11847.5 11879.8 12367.0 660.3 664.8 666.8 672.7 677.5 5357.8 5366.2 5391.9 5418.5 5523.9 123940.4 125095.0 125885.0 127803.0 128114.4 107707.0 108844.0 109219.5 110765.4 114360.0 91792.5 92158.5 94689.5 95233.0 95652.0 9965.6 10040.9 10173.7 10290.2 10363.7 42477.8 43406.6 44412.1 44841.6 45298.3 57116.7 57254.4 57652.0 59191.4 60239.1 14802.4 15071.9 15136.1 15216.0 15305.7 16858.2 16979.8 17049.4 17098.3 17183.2 14736.7 14806.9 14816.6 14829.0 15011.3 15413.9 15785.5 15859.5 15876.4 15902.2 14625.9 14955.6 14973.0 15036.5 15144.3 12432.1 12566.0 12727.9 12889.2 12903.3 11884.2 12035.5 12040.3 12125.9 12467.2 03:55:51 INFO - PID 7560 | -------- Summary: end -------- 03:55:51 INFO - PID 7560 | 03:55:51 INFO - TEST-INFO | 7560: exit 0 03:55:52 INFO - TEST-OK | dromaeo_css | took 1107786ms 03:55:52 INFO - TEST-START | kraken 03:55:52 INFO - Initialising browser for kraken test... 03:55:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52678/getInfo.html -profile /tmp/tmpm0Unco/profile 03:55:52 INFO - TEST-INFO | started process 7926 (/builds/slave/test/build/application/firefox/firefox http://localhost:52678/getInfo.html) 03:55:57 INFO - TEST-INFO | 7926: exit 0 03:55:57 INFO - Browser initialized. 03:55:57 INFO - Running cycle 1/1 for kraken test... 03:55:57 INFO - Using env: {'DISPLAY': ':0', 03:55:57 INFO - 'HOME': '/home/cltbld', 03:55:57 INFO - 'JSGC_DISABLE_POISONING': '1', 03:55:57 INFO - 'LANG': 'en_US.UTF-8', 03:55:57 INFO - 'LANGUAGE': 'en_US:en', 03:55:57 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:55:57 INFO - 'LOGNAME': 'cltbld', 03:55:57 INFO - 'MAIL': '/var/mail/cltbld', 03:55:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:55:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:55:57 INFO - 'MOZ_CRASHREPORTER': '1', 03:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:57 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:55:57 INFO - 'MOZ_NO_REMOTE': '1', 03:55:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:55:57 INFO - 'NO_EM_RESTART': '1', 03:55:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:57 INFO - 'PWD': '/builds/slave/test', 03:55:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:55:57 INFO - 'RUST_BACKTRACE': 'full', 03:55:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:55:57 INFO - 'SHELL': '/bin/bash', 03:55:57 INFO - 'SHLVL': '1', 03:55:57 INFO - 'STYLO_FORCE_DISABLED': '1', 03:55:57 INFO - 'TERM': 'linux', 03:55:57 INFO - 'TMOUT': '86400', 03:55:57 INFO - 'USER': 'cltbld', 03:55:57 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256', 03:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:57 INFO - '_': '/tools/buildbot/bin/python'} 03:55:57 INFO - TEST-INFO | started process 8160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm0Unco/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:57 INFO - PID 8160 | 03:55:57 INFO - PID 8160 | (/builds/slave/test/build/application/firefox/firefox:8210): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:55:57 INFO - PID 8160 | 03:56:08 INFO - PID 8160 | RSS: Main: 153571328 03:56:08 INFO - PID 8160 | 03:56:10 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:11 INFO - PID 8160 | RSS: Main: 160841728 03:56:11 INFO - PID 8160 | 03:56:14 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-dft) 03:56:15 INFO - PID 8160 | RSS: Main: 160546816 03:56:15 INFO - PID 8160 | 03:56:18 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-fft) 03:56:18 INFO - PID 8160 | RSS: Main: 155721728 03:56:18 INFO - PID 8160 | 03:56:20 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52678/tests/kraken/driver.html?testName=audio-oscillator) 03:56:21 INFO - PID 8160 | RSS: Main: 156729344 03:56:21 INFO - PID 8160 | 03:56:23 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:24 INFO - PID 8160 | RSS: Main: 156753920 03:56:24 INFO - PID 8160 | 03:56:27 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52678/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:27 INFO - PID 8160 | RSS: Main: 158982144 03:56:27 INFO - PID 8160 | 03:56:31 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52678/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:32 INFO - PID 8160 | RSS: Main: 159494144 03:56:32 INFO - PID 8160 | 03:56:35 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52678/tests/kraken/driver.html?testName=json-parse-financial) 03:56:35 INFO - PID 8160 | RSS: Main: 159387648 03:56:35 INFO - PID 8160 | 03:56:37 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:37 INFO - PID 8160 | RSS: Main: 159555584 03:56:37 INFO - PID 8160 | 03:56:39 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:40 INFO - PID 8160 | RSS: Main: 159645696 03:56:40 INFO - PID 8160 | 03:56:42 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:43 INFO - PID 8160 | RSS: Main: 156520448 03:56:43 INFO - PID 8160 | 03:56:45 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:46 INFO - PID 8160 | RSS: Main: 157011968 03:56:46 INFO - PID 8160 | 03:56:49 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:49 INFO - PID 8160 | RSS: Main: 157347840 03:56:49 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | Cycle 1(1): loaded http://localhost:52678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52678/tests/kraken/driver.html?testName=ai-astar) 03:56:51 INFO - PID 8160 | RSS: Main: 158392320 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | __start_tp_report 03:56:51 INFO - PID 8160 | _x_x_mozilla_page_load 03:56:51 INFO - PID 8160 | _x_x_mozilla_page_load_details 03:56:51 INFO - PID 8160 | |i|pagename|runs| 03:56:51 INFO - PID 8160 | |0;ai-astar;108;107;108;108;107;107;107;110;108;107 03:56:51 INFO - PID 8160 | |1;audio-beat-detection;122;123;116;117;118;119;121;117;118;115 03:56:51 INFO - PID 8160 | |2;audio-dft;164;163;163;162;163;164;163;165;166;168 03:56:51 INFO - PID 8160 | |3;audio-fft;75;75;73;75;73;74;74;73;75;74 03:56:51 INFO - PID 8160 | |4;audio-oscillator;80;81;79;80;78;80;78;78;78;79 03:56:51 INFO - PID 8160 | |5;imaging-gaussian-blur;118;114;114;114;115;113;113;113;114;117 03:56:51 INFO - PID 8160 | |6;imaging-darkroom;157;147;148;147;147;150;148;148;149;149 03:56:51 INFO - PID 8160 | |7;imaging-desaturate;94;95;94;94;94;100;100;95;94;94 03:56:51 INFO - PID 8160 | |8;json-parse-financial;55;54;54;51;53;56;53;55;55;53 03:56:51 INFO - PID 8160 | |9;json-stringify-tinderbox;38;38;38;39;38;38;39;38;39;38 03:56:51 INFO - PID 8160 | |10;stanford-crypto-aes;74;77;75;76;75;73;73;74;73;73 03:56:51 INFO - PID 8160 | |11;stanford-crypto-ccm;118;111;111;113;113;119;116;114;113;118 03:56:51 INFO - PID 8160 | |12;stanford-crypto-pbkdf2;167;169;165;168;177;167;167;168;171;173 03:56:51 INFO - PID 8160 | |13;stanford-crypto-sha256-iterative;64;69;65;67;66;64;66;67;64;64 03:56:51 INFO - PID 8160 | __end_tp_report 03:56:51 INFO - PID 8160 | __start_cc_report 03:56:51 INFO - PID 8160 | _x_x_mozilla_cycle_collect,730 03:56:51 INFO - PID 8160 | __end_cc_report 03:56:51 INFO - PID 8160 | __startTimestamp1506164211745__endTimestamp 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | ------- Summary: start ------- 03:56:51 INFO - PID 8160 | Number of tests: 14 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:0.95 (0.9%) stddev-sans-first:1.00 03:56:51 INFO - PID 8160 | Values: 108.0 107.0 108.0 108.0 107.0 107.0 107.0 110.0 108.0 107.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:118.50 stddev:2.63 (2.2%) stddev-sans-first:2.49 03:56:51 INFO - PID 8160 | Values: 122.0 123.0 116.0 117.0 118.0 119.0 121.0 117.0 118.0 115.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:1.79 (1.1%) stddev-sans-first:1.90 03:56:51 INFO - PID 8160 | Values: 164.0 163.0 163.0 162.0 163.0 164.0 163.0 165.0 166.0 168.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:0.88 (1.2%) stddev-sans-first:0.87 03:56:51 INFO - PID 8160 | Values: 75.0 75.0 73.0 75.0 73.0 74.0 74.0 73.0 75.0 74.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:79.50 stddev:1.10 (1.4%) stddev-sans-first:1.12 03:56:51 INFO - PID 8160 | Values: 80.0 81.0 79.0 80.0 78.0 80.0 78.0 78.0 78.0 79.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.72 (1.5%) stddev-sans-first:1.27 03:56:51 INFO - PID 8160 | Values: 118.0 114.0 114.0 114.0 115.0 113.0 113.0 113.0 114.0 117.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:148.50 stddev:2.98 (2.0%) stddev-sans-first:1.05 03:56:51 INFO - PID 8160 | Values: 157.0 147.0 148.0 147.0 147.0 150.0 148.0 148.0 149.0 149.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.00 stddev:2.46 (2.6%) stddev-sans-first:2.55 03:56:51 INFO - PID 8160 | Values: 94.0 95.0 94.0 94.0 94.0 100.0 100.0 95.0 94.0 94.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.45 (2.7%) stddev-sans-first:1.48 03:56:51 INFO - PID 8160 | Values: 55.0 54.0 54.0 51.0 53.0 56.0 53.0 55.0 55.0 53.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 03:56:51 INFO - PID 8160 | Values: 38.0 38.0 38.0 39.0 38.0 38.0 39.0 38.0 39.0 38.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#10] stanford-crypto-aes Cycles:10 Average:74.30 Median:74.50 stddev:1.42 (1.9%) stddev-sans-first:1.50 03:56:51 INFO - PID 8160 | Values: 74.0 77.0 75.0 76.0 75.0 73.0 73.0 74.0 73.0 73.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:115.00 stddev:2.95 (2.6%) stddev-sans-first:2.86 03:56:51 INFO - PID 8160 | Values: 118.0 111.0 111.0 113.0 113.0 119.0 116.0 114.0 113.0 118.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:168.50 stddev:3.55 (2.1%) stddev-sans-first:3.68 03:56:51 INFO - PID 8160 | Values: 167.0 169.0 165.0 168.0 177.0 167.0 167.0 168.0 171.0 173.0 03:56:51 INFO - PID 8160 | 03:56:51 INFO - PID 8160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.71 (2.6%) stddev-sans-first:1.72 03:56:51 INFO - PID 8160 | Values: 64.0 69.0 65.0 67.0 66.0 64.0 66.0 67.0 64.0 64.0 03:56:51 INFO - PID 8160 | -------- Summary: end -------- 03:56:51 INFO - PID 8160 | 03:56:52 INFO - PID 8160 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:56:52 INFO - TEST-INFO | 8160: exit 0 03:56:52 INFO - TEST-OK | kraken | took 60451ms 03:56:52 INFO - SUITE-END | took 1168s 03:56:52 INFO - Completed test suite (00:19:28) 03:56:52 INFO - javascript benchmark 03:56:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8692.820219776278, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.6711745266743, 3161.367726454709, 3167.7465802735783, 3176.825274609897, 3203.07110937828, 6097.146399504062, 6240.43836054755, 6273.153124328214, 6276.905846412302, 6284.842878928029, 6171.105189747484, 6232.2832874219475, 6334.778282760104, 6352.015437607167, 6382.457491113261, 5705.5435565154685, 5797.043487824525, 5799.18811366409, 5816.418358164171, 5857.092150716646, 110.6850839078079, 5627.0, 5743.483086522212, 5819.068948968166, 5821.243238379005, 5702.572307076985, 5703.714814259291, 5761.827145185651, 5767.077267637158, 5778.248827652399, 5649.0, 5651.011073062239, 5732.140178973145, 5754.769809207627, 5761.0494268445655, 5626.240457538262, 5682.374938756733, 5747.3677895431465, 5761.3950535194035, 5774.220480235156, 6096.908546371808, 6192.9380706192815, 6203.31763506014, 6277.7802776903045, 6279.120923070774, 6450.8064758057335, 6614.305497922697, 6654.6672666366485, 6672.599644021374, 6749.966250168767, 6647.069410282565, 6651.102101216371, 6659.9001014984815, 6669.633170175638, 6674.199096108498, 6157.692115394212, 6263.091851681481, 6271.686415679198, 6289.905651415233, 6297.0, 6843.692033858489, 6855.622940738208, 6927.58434493932, 6929.549579277331, 6938.618375989268, 6503.2521260054755, 6534.705938232791, 6535.411812936859, 6580.638064906476, 6642.568233064835, 6712.261651218362, 6718.32816718334, 6731.124953755981, 6734.124563806772, 6738.932610673928, 6623.172103487064, 6637.502187335969, 6691.933080669131, 6703.497237707192, 6729.192496900403, 6686.498512611476, 6698.765543206062, 6757.189137303555, 6765.646870625895, 6774.593524388552, 5198.92201616976, 5286.788528458896, 5308.761105750174, 5326.92009619856, 5402.756875940592, 4669.60308373792, 4683.227267500824, 4738.076075165379, 4744.739039352799, 4760.071786001697, 5713.228714123623, 5803.8549036274435, 5875.970620146957, 5884.705764711747, 5888.234529511222, 6704.061431399608, 6709.0, 6773.153355830521, 6784.0, 6787.321267873272, 5743.511801496836, 5811.564132690065, 5832.708364581754, 5869.501092407193, 5884.146798714162, 5814.215080964101, 5875.177475153482, 5888.352281249059, 5891.027980383189, 5894.646321220741, 6507.739690412331, 6585.111010013683, 6587.143671322698, 6600.2409722882485, 6638.933610663928, 6577.901331480031, 6637.800865974028, 6645.435138013227, 6657.467402607683, 6657.933420665925, 6563.310852360624, 6568.7372505099265, 6572.80281591553, 6573.5398522103, 6574.539782215199, 6532.608043517214, 6538.378854008862, 6637.701303441453, 6642.800715978528, 6647.767328143492, 6696.59820410777, 6705.865882682417, 6707.5975441473665, 6799.184097908283, 6817.2501024888215, 6305.1172835803945, 6450.871097557815, 6452.419282264619, 6521.64130972801, 6538.803835884931, 6375.234971803413, 6413.0, 6437.710303036468, 6442.742290308335, 6451.096846441408, 6412.61524308543, 6451.483881289391, 6462.353764623688, 6471.546991710535, 6477.093206950936, 6492.837679058061, 6505.60966342021, 6600.339966003361, 6611.206655201407, 6617.338266173537, 6257.9687101564205, 6280.340564240872, 6335.429811317003, 6354.110424540476, 6365.96817015912], "value": 6070.573409230384, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.162185918982, 763.7021561590977, 765.7664412354234, 768.2970082374626, 770.6994272233826, 37884.810575947115, 41477.79261103694, 41539.584604153984, 41657.0, 42002.36996445048, 38228.23543529128, 38338.233235335276, 38345.808270958674, 38370.232595348076, 38417.42373864394, 7220.530665506738, 7303.379212766895, 7881.487703299296, 8124.309433698143, 8145.796355091141, 8014.879776803353, 8070.596470176468, 8122.675092996273, 8133.877991830127, 8136.389770767187, 8106.0, 8145.226203510657, 8148.959255203746, 8179.918200818005, 8180.0, 8089.069756977935, 8096.230858068474, 8109.7161599343735, 8116.2695357418115, 8118.14759450258, 8003.1996800320085, 8079.798005049862, 8080.676772929076, 8083.272505474477, 8092.757217283491, 37838.4324235134, 38049.809750951346, 38053.429198562044, 38161.23677526434, 38242.426363604565, 3546.989108104178, 3561.6794488495902, 3570.62508436613, 3579.7494175407733, 3596.1549035976523, 31493.0, 31554.684453155405, 31574.842125789222, 31640.0, 31711.0, 5124.666896651743, 5173.27574139617, 5199.376074871002, 5233.581313494949, 5245.213218017289, 185425.0, 185655.0, 185900.0, 186937.99999999863, 187232.0, 43073.78463107665, 43931.78034109809, 49436.75281623569, 49518.0, 50230.748846255534, 52702.209466858025, 52800.0, 52856.62145203475, 52950.20574691382, 52968.0, 16237.756433653505, 16287.267072981744, 16334.75497867533, 16381.42665006743, 16409.507714768577, 13271.73456530864, 13332.066755327034, 13343.06598538093, 13351.866481335257, 13478.932605337106, 14221.217833019076, 14328.0, 14380.280985950661, 14409.06341087826, 14607.707845843024, 5959.970200148971, 6016.879662406727, 6054.516643422302, 6087.908681369783, 6095.35998720128, 1002.2483137646765, 1026.9026583930215, 1031.654395777408, 1038.683201623512, 1045.10643399892, 23154.65268020981, 23157.88421057884, 23198.42003949881, 23291.0, 23396.064157433513, 1130.1467392118898, 1133.3766428464312, 1133.4049623947494, 1141.8116010858282, 1143.4625725908809, 12085.637430877088, 12155.392230388445, 12299.831516005965, 12352.0, 12358.073144514017, 209468.0, 214794.0, 214945.0, 215635.0, 216995.0, 51928.48071519237, 52276.21585676218, 52431.73784131055, 52716.0, 52971.0, 1433.7347590695754, 1461.335092532895, 1477.9187144707143, 1487.1820498725874, 1487.7396455620224, 22813.885930570905, 22819.315420537412, 22822.42943926415, 22859.542809144055, 22993.88503057474, 34172.31655366829, 34208.486872697424, 34265.0, 34271.0, 34283.31433371269, 193223.0, 193259.0, 194374.0, 194510.0, 194679.0, 33559.32881342409, 34349.82825085858, 35085.47371789476, 35472.46791298081, 35600.10999725028, 44855.32717009182, 46100.0, 46415.76792116153, 46527.53472465232, 46543.301850471595, 32884.67115328816, 33075.83462082674, 33191.0, 33198.0, 33222.0, 33208.833955830065, 33228.50157247692, 33253.66746332506, 33378.666213338525, 33783.4932476018, 36864.81567592145, 37067.25865482729, 37135.6286437143, 37432.81283593673, 37560.24879502449, 32330.191745206557, 32353.35293294168, 32466.513002304513, 32747.34505309833, 33002.83498582492, 24654.63018054695, 24708.752912470645, 24822.00711971501, 25010.499790004462, 25233.243002709947], "value": 17274.423796546624, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6815719511465, 595.4492094812298, 596.2457491273537, 605.7183409714482, 631.5736877607615, 22181.556368872614, 23138.190163344287, 23143.421414464625, 23160.30519084428, 23230.0, 23178.42053948652, 25615.871920640417, 25987.0, 25994.740052599467, 26036.73963260367, 6638.933610663904, 6812.829679258033, 6823.69293381799, 6880.483963702717, 6886.931130688704, 6655.500837437212, 6789.5926244425245, 6994.2656021117555, 7259.528130671516, 7326.9267307327045, 7360.26397360265, 7360.963195184044, 7363.042804435443, 7371.778846634609, 7377.741779037735, 6940.097787287671, 7250.16623088341, 7257.201707812136, 7366.15289241736, 7377.262273772633, 7031.015657807911, 7093.290670932917, 7096.970939213785, 7098.432125429953, 7104.21853596104, 30380.0, 31606.0, 31618.683813161802, 31715.52426713601, 31735.52396714051, 2107.3677896630948, 2132.029926383492, 2132.5734853029458, 2141.1649456711893, 2143.6677315016195, 20514.487137821525, 21718.13127474899, 21748.13007479699, 21841.890790546106, 21846.890765546228, 2563.487302539481, 2607.674040744907, 2671.238696971354, 2674.585439256899, 2677.397585543257, 125666.37166814199, 127373.0, 131872.34063829618, 140180.0, 146954.0, 20876.37370878876, 21175.36473905785, 22186.44533886666, 22267.888660556593, 22513.549729005656, 42999.0, 43015.784921075196, 43075.0, 43139.35290970638, 43149.35275970863, 10825.67522974312, 10917.945410272898, 10919.617813376493, 10939.617113401151, 11187.105031597453, 8838.39513351521, 8841.425307355, 8889.688860889837, 8930.240929520933, 8961.910380896237, 11190.097683393842, 11330.206885517935, 11580.710482237842, 11627.6511704649, 11661.0, 3882.8446862125766, 3936.2127574485216, 4134.565870583546, 4366.126774645084, 4611.377464042378, 942.8397172480695, 954.3844220477753, 954.746992047108, 960.3901522533241, 975.9072888075622, 18448.63102737938, 18812.623747525246, 18925.62148757017, 19203.135858886384, 19407.417777466697, 1019.3374306700556, 1026.7689769801884, 1035.409816404642, 1041.6874937518714, 1043.0768769638923, 10303.0, 10351.792964140675, 10513.526891289757, 10687.732806679895, 10785.245032847626, 438539.0, 453068.0, 456756.0, 457812.0, 461270.0, 101349.0, 105222.0, 105361.47319263355, 106355.0, 106633.0, 1067.7010437077631, 1078.8651418572679, 1115.9163062770324, 1118.3345909184022, 1182.5506307603227, 20789.376318710463, 20794.376168714964, 20832.687509687064, 20918.372448826558, 20964.266250681154, 54068.0, 56480.0, 56917.0, 57901.0, 58306.0, 70804.64597676978, 71623.0, 72310.63844680953, 72372.0, 72831.0, 20321.49196270105, 20643.690344645143, 20678.896605516875, 20779.68830467514, 20804.271850485162, 23189.188378406674, 23571.29286121419, 23683.64474532849, 23812.88093559521, 23909.0, 18683.0, 18695.719564206818, 19117.617647647246, 19141.0, 19141.712874306617, 16499.917500412903, 16826.57933551671, 17216.397426090025, 17585.560360991076, 17718.11409429549, 18366.357177498725, 19230.615387692447, 19395.806041939966, 19445.416637500897, 19621.72458790174, 20146.496337591678, 20236.494087647927, 20299.79700203038, 20313.79686203119, 20396.184152633727, 18750.624987500447, 18825.34111306098, 18962.52593685169, 19284.517887052934, 19298.22807087701], "value": 13062.31063388498, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.3385656386959, 1351.905366624336, 1358.986410135899, 1360.061557525308, 1364.4951367993845, 15228.54314370568, 15856.603584910368, 15861.286242119118, 15866.286017129229, 15881.602959926007, 15559.92220038901, 15669.0, 15693.136877471734, 15693.21533923305, 15697.0, 2694.393761403683, 2781.3463835998523, 2786.763125134356, 2787.0941943868224, 2787.8327300362043, 2719.279390961387, 2741.2735625059377, 2742.725727427261, 2746.258510202254, 2750.601162831388, 2744.1493137127454, 2857.042890631641, 2861.971380286191, 2862.8854845806245, 2863.9140825775157, 2862.541993281086, 2863.642044744407, 2866.0398766413173, 2884.4519541287086, 2888.1046875468674, 2550.2604244768995, 2830.7169283071735, 2836.489431902257, 2837.120492647286, 2840.5597132444504, 15320.92753507255, 15520.379184832593, 15547.30037148331, 15562.610934726723, 15570.37718491259, 8048.597570121529, 8358.498490090615, 8359.8328033439, 8360.372972027062, 8368.83262334756, 5508.906615486129, 5526.115821468586, 5679.4036626154075, 5723.198752174699, 5748.45389687979, 1905.4188472515877, 1910.2645481489587, 1927.3447028010403, 1940.8544359173118, 1984.7519060117486, 27743.306417339525, 27962.440751185066, 27971.86014069937, 27973.720262797317, 28059.15822525307, 6639.933600664028, 6707.899381509281, 6720.596764194164, 6823.829404264933, 6847.965760171167, 17460.301587936596, 17610.119494025246, 17623.911880440774, 17658.1170941455, 17678.116094195495, 8037.8392432152195, 8165.101838797727, 8189.754307370788, 8200.630971606291, 8250.298724608356, 7382.446316526282, 7581.279778421152, 7587.203343648837, 7653.387728981668, 7655.119661238918, 5082.390113186368, 5203.063448579292, 5230.137027390438, 5289.2330612061805, 5293.311869456946, 1473.4400927647425, 1520.1335238913714, 1540.4839378808, 1573.6065983504125, 1604.8154462236992, 875.146731936357, 890.7194233816327, 894.088030209183, 901.0898992018109, 914.3416739947228, 8814.471131732116, 8894.822103558023, 8917.821643567093, 8952.23905967987, 9110.954445227731, 983.2379905573238, 1006.1296978113879, 1009.3489699144011, 1009.9646512372032, 1011.4285428732743, 5324.121519949243, 5398.379186393537, 5488.25908502355, 5675.744591493392, 5711.514521265739, 21606.243781467572, 21752.782472175077, 22246.0, 22742.886285568467, 22856.0, 22349.664755028687, 22518.0, 22670.65994010091, 22686.773132268798, 22796.0, 10329.0, 11708.590199342982, 11829.17195796286, 11837.88162118385, 11843.88156118445, 8115.715949941724, 8363.163683631832, 8432.325413966746, 8461.365397595082, 8481.109483504144, 19151.13819878081, 19369.51576210606, 19629.70555441641, 19802.70295945533, 19933.0, 19464.1241144146, 19863.801361986196, 19893.701594475806, 20277.49306267355, 20912.268070617454, 11196.104311655212, 11238.606648767254, 11397.202195846543, 11403.144764142557, 11405.54377824911, 14196.645083872985, 14495.565133046026, 14501.927490362481, 14516.274186290855, 14517.0, 11530.250533715282, 11566.30602163873, 11579.421028948687, 11739.178257521891, 11800.82298765502, 11505.48225329879, 11574.47914843851, 11666.241694290184, 11723.237989530653, 11833.230839995373, 9930.553125109243, 10141.138003269509, 10142.645007424704, 10144.695659130239, 10169.644062457779, 7365.447591430557, 7377.668004939898, 7417.851642967218, 7461.067366579177, 7467.141278752796, 7561.130469996021, 7562.924370756222, 7588.241175882367, 7617.428692847948, 7717.0], "value": 6879.164716610763, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.862501437119, 529.7907326605992, 545.4490964126232, 546.2652732075358, 555.1949672974185, 6222.937770622292, 6244.281907580618, 6245.437910588057, 6326.4011349955335, 6344.1752572165615, 6195.845103872405, 6214.285357183925, 6219.533534984872, 6251.187345645071, 6313.526485513582, 5156.355455568054, 5183.974080129594, 5228.2680424740565, 5228.660137091077, 5237.947620523803, 4974.850754477371, 5097.133487307148, 5129.461406552315, 5196.480351964792, 5208.114620514521, 5064.797408103672, 5071.1632580624155, 5127.846304552078, 5145.073886700392, 5149.433562308143, 5069.239614057884, 5081.618878584121, 5091.261767043758, 5098.5921126309995, 5125.871853203663, 4698.624110071186, 4703.8249181802485, 4706.247000479941, 4710.034442939189, 4710.882227944295, 6121.571489995702, 6129.1419201311855, 6173.135760993465, 6183.81448556544, 6211.130441738161, 5791.333996590404, 5841.970790146022, 5883.441073098049, 5890.70546472679, 5918.940810591925, 6485.967570162119, 6544.70548825304, 6556.508261880331, 6559.442447391977, 6601.669916504204, 4886.560209581119, 5070.569001634865, 5125.846224613268, 5151.613628977804, 5184.481551844823, 6651.800445986628, 6732.1921369435495, 6758.256591774901, 6780.932190678129, 6849.1096157499205, 5322.494363035506, 5330.680159190461, 5373.892522149535, 5384.273123128328, 5415.83752487426, 5404.513593776579, 5409.675419474844, 5446.91829622556, 5456.563474921997, 5468.507834294933, 5807.274090738658, 5836.556431705314, 5844.298684157929, 5905.704714764244, 5948.464638182498, 6565.573237739532, 6579.868402631921, 6599.373059559334, 6620.271770105284, 6656.467482601381, 1886.122952826942, 1895.5924476237676, 1898.9715154272697, 1908.0, 1915.7126431035178, 1329.9867001329862, 1396.8882489400823, 1397.3921344215298, 1408.8802451791507, 1421.289355322339, 5678.346990096109, 5728.455796699307, 5731.770729170787, 5745.971270143623, 5789.3921138279875, 6534.640594767334, 6580.76967306142, 6592.274849766522, 6617.735290588323, 6647.767328143492, 5704.1443783432815, 5732.71336433185, 5746.0, 5771.88456230873, 5775.740091695884, 3490.528778614905, 3517.43721004638, 3518.419460788992, 3530.717542596586, 3541.1678255609913, 6561.0, 6580.76967306142, 6604.834879127964, 6638.302978187221, 6649.667516624149, 6685.866282674319, 6716.328367163244, 6782.762603308861, 6870.3473170048765, 6871.14110736158, 6578.730338033371, 6602.537822352389, 6616.470682345401, 6636.435902948207, 6643.402093811484, 6618.139641846529, 6620.238672552526, 6621.735130594722, 6659.367360100783, 6661.3338666132995, 6491.967540162269, 6497.350264973465, 6543.509236807354, 6560.278369379269, 6629.171353580802, 6364.872702546016, 6450.741970321323, 6469.5794773339585, 6533.477321814338, 6576.2708475981935, 5330.866728331667, 5343.866403339947, 5364.4099149094345, 5368.919466208088, 5389.56883449331, 6406.87186256263, 6542.771003014872, 6590.176227971504, 6642.202935647753, 6646.371638948489, 6107.0, 6224.595401298901, 6368.808935731936, 6400.55196136266, 6421.5825971311715, 6315.494760419064, 6386.594949111188, 6402.167718196604, 6414.358564143548, 6451.1936007999, 6191.907121393273, 6227.688615569113, 6232.220972378453, 6296.181496405621, 6332.366763323631, 6297.0, 6342.841428964312, 6360.713767880549, 6430.356964303533, 6459.321771214143, 6114.785982490592, 6144.201253836973, 6211.192544969125, 6217.191765070512, 6233.688315584112], "value": 5133.2958928396965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.5866501409351, 908.110052148894, 936.6206686292049, 940.0364626258084, 944.8724422203005, 19041.71437428438, 20047.498812529695, 20155.899220503914, 20183.09176087076, 20183.899080504594, 17857.10714464278, 17935.461936141935, 18134.274629014824, 18686.0, 18953.810461895377, 971.1550950672906, 990.1534188269035, 993.2500961773886, 993.3592832622954, 994.6866736977829, 966.1063516247478, 984.8621193032981, 1006.9848952265685, 1007.8337074382719, 1011.716719318592, 1069.4332004037872, 1077.8113830079744, 1079.9028087472127, 1079.9730006749814, 1080.076534562949, 987.2792861211284, 1020.5611587017579, 1057.3919996002292, 1059.1050562274866, 1065.8347956066823, 754.8716718157872, 755.3164386230416, 756.406221116421, 757.1066141952493, 760.2739383888373, 20785.27251546204, 21004.264850730306, 21009.68485472719, 21047.158113675436, 21095.894520527298, 22286.88856555707, 22948.196813111626, 23138.190163344203, 23202.883985580134, 23203.419914502105, 17117.887337323158, 17508.21213045416, 17573.12134393288, 17602.11989400525, 17616.295348186057, 3767.811609419518, 3788.6021967693546, 3793.6775374093236, 3794.051487128218, 3800.5819359870393, 138618.0, 138887.0, 141098.29450852782, 141209.0, 142758.28620856933, 15191.164485953157, 15448.459303924308, 15484.30320635574, 15515.689686206213, 15530.301136448887, 27553.311167220578, 27953.440931181263, 28286.292842679097, 28575.0, 28646.427071458453, 8573.27127194183, 8773.122687731176, 8782.121787821166, 8782.2096011358, 8786.956065219632, 4394.406755088022, 4419.513853476179, 4505.7521836298665, 4554.339620754972, 4598.609118224921, 5592.077307244259, 5680.233168522279, 5685.289338832646, 5698.17376480408, 5699.74351154199, 933.0855761353776, 959.5058544849409, 975.0, 975.0541974284932, 975.380633297861, 660.1945626335862, 680.3774546290089, 685.1230425055837, 688.5214775730819, 690.5304393012799, 11137.665870023913, 11784.0, 11847.466863991142, 11879.76240475203, 12367.010639148846, 660.2605082307846, 664.8271449423088, 666.8066260784415, 672.6670298202421, 677.5325025732229, 5357.848062666545, 5366.221897824794, 5391.865203369869, 5418.45815418455, 5523.861903452365, 123940.38029809794, 125095.0, 125885.0, 127803.0, 128114.35942820227, 107707.0, 108844.0, 109219.45390273156, 110765.44617277023, 114360.0, 91792.54103729573, 92158.53920730487, 94689.52655236817, 95233.0476695238, 95652.0, 9965.551550180115, 10040.899591004289, 10173.694789156338, 10290.176785856964, 10363.689089327332, 42477.78761106174, 43406.56593434152, 44412.11175776531, 44841.551584483735, 45298.32052519281, 57116.714416427654, 57254.42745572491, 57652.0, 59191.40808592031, 60239.09641355296, 14802.407903683732, 15071.924640376728, 15136.091834489966, 15216.0, 15305.693886121993, 16858.15709214559, 16979.830201697823, 17049.40327088546, 17098.316067357166, 17183.226754796313, 14736.705265894836, 14806.851931480547, 14816.555503334917, 14829.0, 15011.32449039774, 15413.922930385277, 15785.526434206991, 15859.52421427359, 15876.364945402516, 15902.204889755698, 14625.85374146245, 14955.551333460013, 14973.0, 15036.473723419627, 15144.318505667492, 12432.12975091735, 12565.994720422526, 12727.872721272668, 12889.226646401246, 12903.290319032543, 11884.168108232341, 12035.45840437165, 12040.277583345027, 12125.878741212475, 12467.189632673848], "value": 8919.742156728707, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 108.0, 108.0, 107.0, 107.0, 107.0, 110.0, 108.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 123.0, 116.0, 117.0, 118.0, 119.0, 121.0, 117.0, 118.0, 115.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 163.0, 164.0, 163.0, 165.0, 166.0, 168.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 75.0, 73.0, 74.0, 74.0, 73.0, 75.0, 74.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 80.0, 78.0, 80.0, 78.0, 78.0, 78.0, 79.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 114.0, 115.0, 113.0, 113.0, 113.0, 114.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 147.0, 148.0, 147.0, 147.0, 150.0, 148.0, 148.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 100.0, 100.0, 95.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 51.0, 53.0, 56.0, 53.0, 55.0, 55.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 76.0, 75.0, 73.0, 73.0, 74.0, 73.0, 73.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 111.0, 111.0, 113.0, 113.0, 119.0, 116.0, 114.0, 113.0, 118.0], "value": 114.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 165.0, 168.0, 177.0, 167.0, 167.0, 168.0, 171.0, 173.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 65.0, 67.0, 66.0, 64.0, 66.0, 67.0, 64.0, 64.0], "value": 65.6, "unit": "score"}]}]} 03:56:52 INFO - Return code: 0 03:56:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:53 INFO - # TBPL SUCCESS # 03:56:53 INFO - Running post-action listener: _package_coverage_data 03:56:53 INFO - Running post-action listener: _resource_record_post_action 03:56:53 INFO - [mozharness: 2017-09-23 10:56:53.028114Z] Finished run-tests step (success) 03:56:53 INFO - Running post-run listener: _resource_record_post_run 03:56:53 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 421888; Write bytes: 343977984; Read time: 28; Write time: 213516 03:56:53 INFO - TinderboxPrint: CPU usage
13.1% 03:56:53 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 28 03:56:53 INFO - TinderboxPrint: I/O write bytes / time
343,977,984 / 213,516 03:56:53 INFO - TinderboxPrint: CPU idle
8,220.8 (86.9%) 03:56:53 INFO - TinderboxPrint: CPU user
1,192.2 (12.6%) 03:56:53 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 18014208; Read time: 0; Write time: 3444 03:56:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:56:53 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 417792; Write bytes: 325963776; Read time: 20; Write time: 210072 03:56:53 INFO - Running post-run listener: _upload_blobber_files 03:56:53 INFO - Blob upload gear active. 03:56:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:56:53 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'] 03:56:53 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 03:56:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:57 INFO - (blobuploader) - INFO - Done attempting. 03:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:04 INFO - (blobuploader) - INFO - Done attempting. 03:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:05 INFO - (blobuploader) - INFO - Done attempting. 03:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:57:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:06 INFO - (blobuploader) - INFO - Done attempting. 03:57:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:06 INFO - Return code: 0 03:57:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5117b2338aa51232f620bc524e33d736e83db7bba107d1bb7d630358043d53dcd2b30a53bef936de9d62ff0ec9c14b4f8d9474d3d6b0315279745515a5985f83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b48c3ab1a29329e85c4edccfa814b3fbccf4f2fc7459ca311134965d14be5c57aa7bb100bb33cda576079bbe9bb4a6abec7651c5d984d1aa2ec84e80eba75f17", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7979725de0ed9a965a0785c83d7671184961b7f65ce2795b51c1ac21cf6cb4b43bb1e16d5b8c7dfed3c4c1ae83418837ca83e1b4c46a1e380233c645253ad45", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618686620734669bcbc1cd13c29e22ed18016d8aeb04e8bfc8a527d6a8ef0eb5dc9d3e75bd496fb04a021cfda7148cffce18f50558b255e129320b1c2e2f3225"} 03:57:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:06 INFO - Contents: 03:57:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5117b2338aa51232f620bc524e33d736e83db7bba107d1bb7d630358043d53dcd2b30a53bef936de9d62ff0ec9c14b4f8d9474d3d6b0315279745515a5985f83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b48c3ab1a29329e85c4edccfa814b3fbccf4f2fc7459ca311134965d14be5c57aa7bb100bb33cda576079bbe9bb4a6abec7651c5d984d1aa2ec84e80eba75f17", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7979725de0ed9a965a0785c83d7671184961b7f65ce2795b51c1ac21cf6cb4b43bb1e16d5b8c7dfed3c4c1ae83418837ca83e1b4c46a1e380233c645253ad45", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618686620734669bcbc1cd13c29e22ed18016d8aeb04e8bfc8a527d6a8ef0eb5dc9d3e75bd496fb04a021cfda7148cffce18f50558b255e129320b1c2e2f3225"} 03:57:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:06 INFO - Copying logs to upload dir... 03:57:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.663844 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-23 03:57:06.706630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:06.714637) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256 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/5117b2338aa51232f620bc524e33d736e83db7bba107d1bb7d630358043d53dcd2b30a53bef936de9d62ff0ec9c14b4f8d9474d3d6b0315279745515a5985f83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b48c3ab1a29329e85c4edccfa814b3fbccf4f2fc7459ca311134965d14be5c57aa7bb100bb33cda576079bbe9bb4a6abec7651c5d984d1aa2ec84e80eba75f17", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7979725de0ed9a965a0785c83d7671184961b7f65ce2795b51c1ac21cf6cb4b43bb1e16d5b8c7dfed3c4c1ae83418837ca83e1b4c46a1e380233c645253ad45", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618686620734669bcbc1cd13c29e22ed18016d8aeb04e8bfc8a527d6a8ef0eb5dc9d3e75bd496fb04a021cfda7148cffce18f50558b255e129320b1c2e2f3225"} build_url:https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/O6UesEjKQLKs2XYkonDMAA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5117b2338aa51232f620bc524e33d736e83db7bba107d1bb7d630358043d53dcd2b30a53bef936de9d62ff0ec9c14b4f8d9474d3d6b0315279745515a5985f83", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b48c3ab1a29329e85c4edccfa814b3fbccf4f2fc7459ca311134965d14be5c57aa7bb100bb33cda576079bbe9bb4a6abec7651c5d984d1aa2ec84e80eba75f17", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7979725de0ed9a965a0785c83d7671184961b7f65ce2795b51c1ac21cf6cb4b43bb1e16d5b8c7dfed3c4c1ae83418837ca83e1b4c46a1e380233c645253ad45", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618686620734669bcbc1cd13c29e22ed18016d8aeb04e8bfc8a527d6a8ef0eb5dc9d3e75bd496fb04a021cfda7148cffce18f50558b255e129320b1c2e2f3225"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:06.745771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:06.746079) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1506162985.701123-997919256 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 03:57:06.828223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 03:57:06.828533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 03:57:06.828869) ========= ========= Total master_lag: 0.22 =========