builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-046 starttime: 1507120961.88 results: success (0) revision: 933b30269777f718a14d2fc379e563a051b14618 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:41.879223) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:41.879708) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:41.880002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:41.941093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:41.941488) ========= 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=652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 05:42:41-- 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% 41.6M=0s 2017-10-04 05:42:42 (41.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085245 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:42.071543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:42.071948) ========= 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=652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018847 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:42.124765) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-04 05:42:42.125206) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 933b30269777f718a14d2fc379e563a051b14618 --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 933b30269777f718a14d2fc379e563a051b14618 --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=652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 05:42:42,191 truncating revision to first 12 chars 2017-10-04 05:42:42,191 Setting DEBUG logging. 2017-10-04 05:42:42,191 attempt 1/10 2017-10-04 05:42:42,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/933b30269777?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 05:42:43,001 unpacking tar archive at: mozilla-central-933b30269777/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116725 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-04 05:42:43.270630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:43.278287) ========= script_repo_revision: 933b30269777f718a14d2fc379e563a051b14618 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:43.278779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:43.279067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 05:42:43.296484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-04 05:42:43.296861) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:42:43 INFO - MultiFileLogger online at 20171004 05:42:43 in /builds/slave/test 05:42:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:42:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:42:43 INFO - {'append_to_log': False, 05:42:43 INFO - 'base_work_dir': '/builds/slave/test', 05:42:43 INFO - 'blob_upload_branch': 'Firefox', 05:42:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:42:43 INFO - 'branch': 'Firefox', 05:42:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:42:43 INFO - 'code_coverage': False, 05:42:43 INFO - 'config_files': ('talos/linux_config.py',), 05:42:43 INFO - 'default_actions': ('clobber', 05:42:43 INFO - 'read-buildbot-config', 05:42:43 INFO - 'download-and-extract', 05:42:43 INFO - 'populate-webroot', 05:42:43 INFO - 'create-virtualenv', 05:42:43 INFO - 'install', 05:42:43 INFO - 'setup-mitmproxy', 05:42:43 INFO - 'run-tests'), 05:42:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:42:43 INFO - 'disable_ccov_upload': False, 05:42:43 INFO - 'disable_stylo': False, 05:42:43 INFO - 'download_minidump_stackwalk': True, 05:42:43 INFO - 'download_symbols': 'ondemand', 05:42:43 INFO - 'enable_stylo': False, 05:42:43 INFO - 'enable_webrender': False, 05:42:43 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:42:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:42:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:42:43 INFO - 'gecko_profile': False, 05:42:43 INFO - 'gecko_profile_interval': 0, 05:42:43 INFO - 'installer_path': 'installer.exe', 05:42:43 INFO - 'log_level': 'info', 05:42:43 INFO - 'log_name': 'talos', 05:42:43 INFO - 'log_to_console': True, 05:42:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:42:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:42:43 INFO - 'opt_config_files': (), 05:42:43 INFO - 'pip_index': False, 05:42:43 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 05:42:43 INFO - 'system_bits': '32', 05:42:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:42:43 INFO - 'title': 'talos-linux64-ix-046', 05:42:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:42:43 INFO - 'use_talos_json': True, 05:42:43 INFO - 'verify': 'False', 05:42:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:42:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:42:43 INFO - 'work_dir': 'build'} 05:42:43 INFO - [mozharness: 2017-10-04 12:42:43.495942Z] Running clobber step. 05:42:43 INFO - Running pre-action listener: _resource_record_pre_action 05:42:43 INFO - Running main action method: clobber 05:42:43 INFO - rmtree: /builds/slave/test/build 05:42:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:42:44 INFO - Running post-action listener: _resource_record_post_action 05:42:44 INFO - [mozharness: 2017-10-04 12:42:44.501225Z] Finished clobber step (success) 05:42:44 INFO - [mozharness: 2017-10-04 12:42:44.501323Z] Running read-buildbot-config step. 05:42:44 INFO - Running pre-action listener: _resource_record_pre_action 05:42:44 INFO - Running main action method: read_buildbot_config 05:42:44 INFO - Using buildbot properties: 05:42:44 INFO - { 05:42:44 INFO - "project": "", 05:42:44 INFO - "product": "firefox", 05:42:44 INFO - "who": "archaeopteryx@coole-files.de", 05:42:44 INFO - "installer_path": "public/build/target.tar.bz2", 05:42:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 05:42:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:42:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 05:42:44 INFO - "stage_platform": "linux64-pgo", 05:42:44 INFO - "basedir": "/builds/slave/test", 05:42:44 INFO - "buildnumber": 50, 05:42:44 INFO - "platform": "ubuntu64_hw", 05:42:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:42:44 INFO - "slavebuilddir": "test", 05:42:44 INFO - "taskId": "eqyvgJz9S6mNvik97bpknA", 05:42:44 INFO - "branch": "mozilla-central", 05:42:44 INFO - "script_repo_revision": "production", 05:42:44 INFO - "revision": "933b30269777f718a14d2fc379e563a051b14618", 05:42:44 INFO - "slavename": "talos-linux64-ix-046", 05:42:44 INFO - "repo_path": "mozilla-central" 05:42:44 INFO - } 05:42:44 INFO - Finding installer, test and symbols from parent task. 05:42:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eqyvgJz9S6mNvik97bpknA'}, attempt #1 05:42:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eqyvgJz9S6mNvik97bpknA'}, attempt #1 05:42:45 INFO - Task dependencies: E6uNJ6CDSdC-LmwGg1i0Wg 05:42:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg'}, attempt #1 05:42:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2 05:42:45 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.test_packages.json 05:42:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.crashreporter-symbols.zip 05:42:45 INFO - Running post-action listener: _resource_record_post_action 05:42:45 INFO - [mozharness: 2017-10-04 12:42:45.832849Z] Finished read-buildbot-config step (success) 05:42:45 INFO - [mozharness: 2017-10-04 12:42:45.833069Z] Running download-and-extract step. 05:42:45 INFO - Running pre-action listener: _resource_record_pre_action 05:42:45 INFO - Running main action method: download_and_extract 05:42:45 INFO - mkdir: /builds/slave/test/build/tests 05:42:45 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')]} 05:42:45 INFO - trying https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.test_packages.json 05:42:45 INFO - Downloading https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:42:46 INFO - Downloaded 989 bytes. 05:42:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:42:46 INFO - Using the following test package requirements: 05:42:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:42:46 INFO - u'common': [u'target.common.tests.zip'], 05:42:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:42:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:42:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:42:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:42:46 INFO - u'mozbase': [u'target.common.tests.zip'], 05:42:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:42:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:42:46 INFO - u'web-platform': [u'target.common.tests.zip', 05:42:46 INFO - u'target.web-platform.tests.tar.gz'], 05:42:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:42:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 05:42:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.common.tests.zip 05:42:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:42:46 INFO - Fetch https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.common.tests.zip into memory 05:42:47 INFO - Content-Length response header: 55882119 05:42:47 INFO - Bytes received: 55882119 05:42:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.talos.tests.zip 05:42:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:42:58 INFO - Fetch https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.talos.tests.zip into memory 05:42:59 INFO - Content-Length response header: 14533844 05:42:59 INFO - Bytes received: 14533844 05:42: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')]} 05:42:59 INFO - trying https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2 05:42:59 INFO - Downloading https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:43:00 INFO - Downloaded 62351745 bytes. 05:43:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2 05:43:00 INFO - mkdir: /builds/slave/test/properties 05:43:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:43:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:43:00 INFO - Contents: 05:43:00 INFO - build_url:https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2 05:43:00 INFO - Running post-action listener: _resource_record_post_action 05:43:00 INFO - Running post-action listener: find_tests_for_verification 05:43:00 INFO - Running post-action listener: set_extra_try_arguments 05:43:00 INFO - [mozharness: 2017-10-04 12:43:00.470428Z] Finished download-and-extract step (success) 05:43:00 INFO - [mozharness: 2017-10-04 12:43:00.470588Z] Running populate-webroot step. 05:43:00 INFO - Running pre-action listener: _resource_record_pre_action 05:43:00 INFO - Running main action method: populate_webroot 05:43:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:43:00 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['tresize', 05:43:00 INFO - 'tcanvasmark']}, 05:43:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:43:00 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['dromaeo_css', 05:43:00 INFO - 'kraken']}, 05:43:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:00 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:43:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'tests': ['damp', 'tps']}, 05:43:00 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['damp', 'tps']}, 05:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:43:00 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['dromaeo_dom']}, 05:43:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:43:00 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['basic_compositor_video', 05:43:00 INFO - 'glvideo']}, 05:43:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:43:00 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['ts_paint_webext', 05:43:00 INFO - 'tp5o_webext']}, 05:43:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:43:00 INFO - 'ts_paint', 05:43:00 INFO - 'tpaint', 05:43:00 INFO - 'sessionrestore', 05:43:00 INFO - 'sessionrestore_many_windows', 05:43:00 INFO - 'sessionrestore_no_auto_restore', 05:43:00 INFO - 'tabpaint', 05:43:00 INFO - 'cpstartup']}, 05:43:00 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['a11yr', 05:43:00 INFO - 'ts_paint', 05:43:00 INFO - 'tpaint', 05:43:00 INFO - 'sessionrestore', 05:43:00 INFO - 'sessionrestore_many_windows', 05:43:00 INFO - 'sessionrestore_no_auto_restore', 05:43:00 INFO - 'tabpaint', 05:43:00 INFO - 'cpstartup']}, 05:43:00 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 05:43:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 05:43:00 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['perf_reftest_singletons']}, 05:43:00 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['perf_reftest']}, 05:43:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:43:00 INFO - 'tsvgr_opacity', 05:43:00 INFO - 'tart', 05:43:00 INFO - 'tscrollx', 05:43:00 INFO - 'tsvg_static']}, 05:43:00 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['tsvgx', 05:43:00 INFO - 'tsvgr_opacity', 05:43:00 INFO - 'tart', 05:43:00 INFO - 'tscrollx', 05:43:00 INFO - 'tsvg_static']}, 05:43:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:43:00 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'talos_options': ['--disable-stylo'], 05:43:00 INFO - 'tests': ['tp5o']}, 05:43:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:43:00 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:43:00 INFO - 'talos_options': ['--mitmproxy', 05:43:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:43:00 INFO - '--firstNonBlankPaint'], 05:43:00 INFO - 'tests': ['tp6_google', 05:43:00 INFO - 'tp6_youtube', 05:43:00 INFO - 'tp6_amazon', 05:43:00 INFO - 'tp6_facebook']}, 05:43:00 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:43:00 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:43:00 INFO - 'talos_options': ['--disable-stylo', 05:43:00 INFO - '--mitmproxy', 05:43:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:43:00 INFO - '--firstNonBlankPaint'], 05:43:00 INFO - 'tests': ['tp6_google', 05:43:00 INFO - 'tp6_youtube', 05:43:00 INFO - 'tp6_amazon', 05:43:00 INFO - 'tp6_facebook']}, 05:43:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:43:00 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 05:43:00 INFO - 'talos_options': ['--stylo-threads=1', 05:43:00 INFO - '--mitmproxy', 05:43:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:43:00 INFO - '--firstNonBlankPaint'], 05:43:00 INFO - 'tests': ['tp6_google', 05:43:00 INFO - 'tp6_youtube', 05:43:00 INFO - 'tp6_amazon', 05:43:00 INFO - 'tp6_facebook']}, 05:43:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'talos_options': ['--xperf_path', 05:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:00 INFO - 'tests': ['tp5n']}, 05:43:00 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 05:43:00 INFO - 'talos_options': ['--disable-stylo', 05:43:00 INFO - '--xperf_path', 05:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:43:00 INFO - 'tests': ['tp5n']}}} 05:43:00 INFO - Running post-action listener: _resource_record_post_action 05:43:00 INFO - [mozharness: 2017-10-04 12:43:00.610021Z] Finished populate-webroot step (success) 05:43:00 INFO - [mozharness: 2017-10-04 12:43:00.610131Z] Running create-virtualenv step. 05:43:00 INFO - Running pre-action listener: _resource_record_pre_action 05:43:00 INFO - Running main action method: create_virtualenv 05:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:43:00 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:43:00 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:43:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:43:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:43:01 INFO - Installing pip...............done. 05:43:01 INFO - Return code: 0 05:43:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:43:01 INFO - Reading from file tmpfile_stdout 05:43:01 INFO - Output received: 05:43:01 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:43:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:43:01 INFO - Using env: {'DISPLAY': ':0', 05:43:01 INFO - 'HOME': '/home/cltbld', 05:43:01 INFO - 'LANG': 'en_US.UTF-8', 05:43:01 INFO - 'LANGUAGE': 'en_US:en', 05:43:01 INFO - 'LOGNAME': 'cltbld', 05:43:01 INFO - 'MAIL': '/var/mail/cltbld', 05:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:01 INFO - 'MOZ_NO_REMOTE': '1', 05:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:01 INFO - 'NO_EM_RESTART': '1', 05:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:01 INFO - 'PWD': '/builds/slave/test', 05:43:01 INFO - 'SHELL': '/bin/bash', 05:43:01 INFO - 'SHLVL': '1', 05:43:01 INFO - 'TERM': 'linux', 05:43:01 INFO - 'TMOUT': '86400', 05:43:01 INFO - 'USER': 'cltbld', 05:43:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:01 INFO - '_': '/tools/buildbot/bin/python'} 05:43:02 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:43:02 INFO - Downloading/unpacking pip>=1.5 05:43:02 INFO - Running setup.py egg_info for package pip 05:43:02 INFO - warning: no files found matching 'pip/cacert.pem' 05:43:02 INFO - warning: no files found matching '*.html' under directory 'docs' 05:43:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:43:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:43:02 INFO - Installing collected packages: pip 05:43:02 INFO - Found existing installation: pip 1.1 05:43:02 INFO - Uninstalling pip: 05:43:02 INFO - Successfully uninstalled pip 05:43:02 INFO - Running setup.py install for pip 05:43:02 INFO - warning: no files found matching 'pip/cacert.pem' 05:43:02 INFO - warning: no files found matching '*.html' under directory 'docs' 05:43:02 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:43:02 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:43:02 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:43:02 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:43:02 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:43:02 INFO - Successfully installed pip 05:43:02 INFO - Cleaning up... 05:43:02 INFO - Return code: 0 05:43:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:43: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')]} 05:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43: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')]} 05:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:02 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:02 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 05:43:02 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 05:43:02 INFO - Using env: {'DISPLAY': ':0', 05:43:02 INFO - 'HOME': '/home/cltbld', 05:43:02 INFO - 'LANG': 'en_US.UTF-8', 05:43:02 INFO - 'LANGUAGE': 'en_US:en', 05:43:02 INFO - 'LOGNAME': 'cltbld', 05:43:02 INFO - 'MAIL': '/var/mail/cltbld', 05:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:02 INFO - 'MOZ_NO_REMOTE': '1', 05:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:02 INFO - 'NO_EM_RESTART': '1', 05:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:02 INFO - 'PWD': '/builds/slave/test', 05:43:02 INFO - 'SHELL': '/bin/bash', 05:43:02 INFO - 'SHLVL': '1', 05:43:02 INFO - 'TERM': 'linux', 05:43:02 INFO - 'TMOUT': '86400', 05:43:02 INFO - 'USER': 'cltbld', 05:43:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:02 INFO - '_': '/tools/buildbot/bin/python'} 05:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:03 INFO - Downloading/unpacking psutil>=3.1.1 05:43: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 05:43: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 05:43: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 05:43: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 05:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:04 INFO - Installing collected packages: psutil 05:43:04 INFO - Running setup.py install for psutil 05:43:04 INFO - building 'psutil._psutil_linux' extension 05:43:04 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 05:43:04 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 05:43:04 INFO - building 'psutil._psutil_posix' extension 05:43:04 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 05:43:04 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 05:43:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:43:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:43:04 INFO - Successfully installed psutil 05:43:04 INFO - Cleaning up... 05:43:04 INFO - Return code: 0 05:43:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:43:04 INFO - Using env: {'DISPLAY': ':0', 05:43:04 INFO - 'HOME': '/home/cltbld', 05:43:04 INFO - 'LANG': 'en_US.UTF-8', 05:43:04 INFO - 'LANGUAGE': 'en_US:en', 05:43:04 INFO - 'LOGNAME': 'cltbld', 05:43:04 INFO - 'MAIL': '/var/mail/cltbld', 05:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:04 INFO - 'MOZ_NO_REMOTE': '1', 05:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:04 INFO - 'NO_EM_RESTART': '1', 05:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:04 INFO - 'PWD': '/builds/slave/test', 05:43:04 INFO - 'SHELL': '/bin/bash', 05:43:04 INFO - 'SHLVL': '1', 05:43:04 INFO - 'TERM': 'linux', 05:43:04 INFO - 'TMOUT': '86400', 05:43:04 INFO - 'USER': 'cltbld', 05:43:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:04 INFO - '_': '/tools/buildbot/bin/python'} 05:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:43:06 INFO - Installing collected packages: mozsystemmonitor 05:43:06 INFO - Running setup.py install for mozsystemmonitor 05:43:06 INFO - Successfully installed mozsystemmonitor 05:43:06 INFO - Cleaning up... 05:43:06 INFO - Return code: 0 05:43:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:43:06 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')]} 05:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:06 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')]} 05:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:07 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:07 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 05:43:07 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 05:43:07 INFO - Using env: {'DISPLAY': ':0', 05:43:07 INFO - 'HOME': '/home/cltbld', 05:43:07 INFO - 'LANG': 'en_US.UTF-8', 05:43:07 INFO - 'LANGUAGE': 'en_US:en', 05:43:07 INFO - 'LOGNAME': 'cltbld', 05:43:07 INFO - 'MAIL': '/var/mail/cltbld', 05:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:07 INFO - 'MOZ_NO_REMOTE': '1', 05:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:07 INFO - 'NO_EM_RESTART': '1', 05:43:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:07 INFO - 'PWD': '/builds/slave/test', 05:43:07 INFO - 'SHELL': '/bin/bash', 05:43:07 INFO - 'SHLVL': '1', 05:43:07 INFO - 'TERM': 'linux', 05:43:07 INFO - 'TMOUT': '86400', 05:43:07 INFO - 'USER': 'cltbld', 05:43:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:07 INFO - '_': '/tools/buildbot/bin/python'} 05:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:43:07 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 05:43:07 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 05:43:07 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 05:43:07 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 05:43:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:43:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:43:08 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 05:43:08 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 05:43:08 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 05:43:08 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 05:43:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:43:08 INFO - warning: no files found matching '*.txt' 05:43:08 INFO - no previously-included directories found matching 'build' 05:43:08 INFO - no previously-included directories found matching 'dist' 05:43:08 INFO - no previously-included directories found matching '.git*' 05:43:08 INFO - Installing collected packages: jsonschema, functools32 05:43:09 INFO - Running setup.py install for functools32 05:43:09 INFO - warning: no files found matching '*.txt' 05:43:09 INFO - no previously-included directories found matching 'build' 05:43:09 INFO - no previously-included directories found matching 'dist' 05:43:09 INFO - no previously-included directories found matching '.git*' 05:43:09 INFO - Successfully installed jsonschema functools32 05:43:09 INFO - Cleaning up... 05:43:09 INFO - Return code: 0 05:43:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:43:09 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')]} 05:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:09 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')]} 05:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:09 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:09 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 05:43:09 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 05:43:09 INFO - Using env: {'DISPLAY': ':0', 05:43:09 INFO - 'HOME': '/home/cltbld', 05:43:09 INFO - 'LANG': 'en_US.UTF-8', 05:43:09 INFO - 'LANGUAGE': 'en_US:en', 05:43:09 INFO - 'LOGNAME': 'cltbld', 05:43:09 INFO - 'MAIL': '/var/mail/cltbld', 05:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:09 INFO - 'MOZ_NO_REMOTE': '1', 05:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:09 INFO - 'NO_EM_RESTART': '1', 05:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:09 INFO - 'PWD': '/builds/slave/test', 05:43:09 INFO - 'SHELL': '/bin/bash', 05:43:09 INFO - 'SHLVL': '1', 05:43:09 INFO - 'TERM': 'linux', 05:43:09 INFO - 'TMOUT': '86400', 05:43:09 INFO - 'USER': 'cltbld', 05:43:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:09 INFO - '_': '/tools/buildbot/bin/python'} 05:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:43:09 INFO - Cleaning up... 05:43:09 INFO - Return code: 0 05:43:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:43:09 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')]} 05:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:09 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')]} 05:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:09 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:09 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 05:43:09 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 05:43:09 INFO - Using env: {'DISPLAY': ':0', 05:43:09 INFO - 'HOME': '/home/cltbld', 05:43:09 INFO - 'LANG': 'en_US.UTF-8', 05:43:09 INFO - 'LANGUAGE': 'en_US:en', 05:43:09 INFO - 'LOGNAME': 'cltbld', 05:43:09 INFO - 'MAIL': '/var/mail/cltbld', 05:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:09 INFO - 'MOZ_NO_REMOTE': '1', 05:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:09 INFO - 'NO_EM_RESTART': '1', 05:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:09 INFO - 'PWD': '/builds/slave/test', 05:43:09 INFO - 'SHELL': '/bin/bash', 05:43:09 INFO - 'SHLVL': '1', 05:43:09 INFO - 'TERM': 'linux', 05:43:09 INFO - 'TMOUT': '86400', 05:43:09 INFO - 'USER': 'cltbld', 05:43:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:09 INFO - '_': '/tools/buildbot/bin/python'} 05:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:43:09 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 05:43:09 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 05:43:09 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 05:43:09 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 05:43:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:43:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:43:10 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 05:43:10 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 05:43:10 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 05:43:10 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 05:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:43:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:43:11 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 05:43:11 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 05:43:11 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 05:43:11 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 05:43:11 INFO - Downloading docopt-0.6.1.tar.gz 05:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:43:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:43:11 INFO - Running setup.py install for blobuploader 05:43:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:43:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:43:11 INFO - Running setup.py install for requests 05:43:11 INFO - Running setup.py install for docopt 05:43:12 INFO - Successfully installed blobuploader requests docopt 05:43:12 INFO - Cleaning up... 05:43:12 INFO - Return code: 0 05:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:12 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')]} 05:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:12 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')]} 05:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:12 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:12 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 05:43:12 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 05:43:12 INFO - Using env: {'DISPLAY': ':0', 05:43:12 INFO - 'HOME': '/home/cltbld', 05:43:12 INFO - 'LANG': 'en_US.UTF-8', 05:43:12 INFO - 'LANGUAGE': 'en_US:en', 05:43:12 INFO - 'LOGNAME': 'cltbld', 05:43:12 INFO - 'MAIL': '/var/mail/cltbld', 05:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:12 INFO - 'MOZ_NO_REMOTE': '1', 05:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:12 INFO - 'NO_EM_RESTART': '1', 05:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:12 INFO - 'PWD': '/builds/slave/test', 05:43:12 INFO - 'SHELL': '/bin/bash', 05:43:12 INFO - 'SHLVL': '1', 05:43:12 INFO - 'TERM': 'linux', 05:43:12 INFO - 'TMOUT': '86400', 05:43:12 INFO - 'USER': 'cltbld', 05:43:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:12 INFO - '_': '/tools/buildbot/bin/python'} 05:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:12 INFO - Running setup.py (path:/tmp/pip-SnSq2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:12 INFO - Running setup.py (path:/tmp/pip-kxgBs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:12 INFO - Running setup.py (path:/tmp/pip-R2cdtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:12 INFO - Running setup.py (path:/tmp/pip-nA6tcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:12 INFO - Running setup.py (path:/tmp/pip-AciTob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:12 INFO - Running setup.py (path:/tmp/pip-MHAC4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:12 INFO - Running setup.py (path:/tmp/pip-fRfZ4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:12 INFO - Running setup.py (path:/tmp/pip-r3Zm15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:12 INFO - Running setup.py (path:/tmp/pip-mmHUdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:12 INFO - Running setup.py (path:/tmp/pip-BjaaTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:13 INFO - Running setup.py (path:/tmp/pip-JcbYBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:13 INFO - Running setup.py (path:/tmp/pip-Zhh1SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:13 INFO - Running setup.py (path:/tmp/pip-slYK2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:13 INFO - Running setup.py (path:/tmp/pip-giBBaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:13 INFO - Running setup.py (path:/tmp/pip-p2P06l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:13 INFO - Running setup.py (path:/tmp/pip-WIvrNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:13 INFO - Running setup.py (path:/tmp/pip-F8nEU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:43:13 INFO - Running setup.py install for manifestparser 05:43:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:43:13 INFO - Running setup.py install for mozcrash 05:43:13 INFO - Running setup.py install for mozdebug 05:43:13 INFO - Running setup.py install for mozdevice 05:43:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:43:13 INFO - Running setup.py install for mozfile 05:43:14 INFO - Running setup.py install for mozhttpd 05:43:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for mozinfo 05:43:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for mozInstall 05:43:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for mozleak 05:43:14 INFO - Running setup.py install for mozlog 05:43:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for moznetwork 05:43:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for mozprocess 05:43:14 INFO - Running setup.py install for mozprofile 05:43:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for mozrunner 05:43:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:43:14 INFO - Running setup.py install for mozscreenshot 05:43:15 INFO - Running setup.py install for moztest 05:43:15 INFO - Running setup.py install for mozversion 05:43:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:43:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:43:15 INFO - Cleaning up... 05:43:15 INFO - Return code: 0 05:43:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:15 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')]} 05:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:15 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')]} 05:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:15 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:15 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 05:43:15 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 05:43:15 INFO - Using env: {'DISPLAY': ':0', 05:43:15 INFO - 'HOME': '/home/cltbld', 05:43:15 INFO - 'LANG': 'en_US.UTF-8', 05:43:15 INFO - 'LANGUAGE': 'en_US:en', 05:43:15 INFO - 'LOGNAME': 'cltbld', 05:43:15 INFO - 'MAIL': '/var/mail/cltbld', 05:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:15 INFO - 'MOZ_NO_REMOTE': '1', 05:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:15 INFO - 'NO_EM_RESTART': '1', 05:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:15 INFO - 'PWD': '/builds/slave/test', 05:43:15 INFO - 'SHELL': '/bin/bash', 05:43:15 INFO - 'SHLVL': '1', 05:43:15 INFO - 'TERM': 'linux', 05:43:15 INFO - 'TMOUT': '86400', 05:43:15 INFO - 'USER': 'cltbld', 05:43:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:15 INFO - '_': '/tools/buildbot/bin/python'} 05:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:43:15 INFO - Running setup.py (path:/tmp/pip-cIh_Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:43:15 INFO - Running setup.py (path:/tmp/pip-TaCMdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:43:15 INFO - Running setup.py (path:/tmp/pip-dSNSQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:43:15 INFO - Running setup.py (path:/tmp/pip-faTOtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:43:15 INFO - Running setup.py (path:/tmp/pip-MUZgSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:43:15 INFO - Running setup.py (path:/tmp/pip-aPYlLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:43:15 INFO - Running setup.py (path:/tmp/pip-RrTQaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:43:15 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)) 05:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:43:15 INFO - Running setup.py (path:/tmp/pip-5IF2La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:43:16 INFO - Running setup.py (path:/tmp/pip-4XYX12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:43:16 INFO - Running setup.py (path:/tmp/pip-oKfYIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:43:16 INFO - Running setup.py (path:/tmp/pip-ZJQve3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:43:16 INFO - Running setup.py (path:/tmp/pip-8AislA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:43:16 INFO - Running setup.py (path:/tmp/pip-CxOHlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:43:16 INFO - Running setup.py (path:/tmp/pip-Uyjq5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:16 INFO - Running setup.py (path:/tmp/pip-VhUq7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:43:16 INFO - Running setup.py (path:/tmp/pip-85OXYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:43:16 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)) 05:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:43:16 INFO - Running setup.py (path:/tmp/pip-TahcHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:43:16 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)) 05:43:16 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)) 05:43:16 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)) 05:43:16 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)) 05:43:16 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)) 05:43:16 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)) 05:43:16 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)) 05:43:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:43:16 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 05:43:16 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 05:43:16 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 05:43:16 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 05:43:17 INFO - Downloading blessings-1.6.tar.gz 05:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:43:17 INFO - Installing collected packages: blessings 05:43:17 INFO - Running setup.py install for blessings 05:43:18 INFO - Successfully installed blessings 05:43:18 INFO - Cleaning up... 05:43:18 INFO - Return code: 0 05:43:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:43:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:18 INFO - Reading from file tmpfile_stdout 05:43:18 INFO - Current package versions: 05:43:18 INFO - argparse == 1.2.1 05:43:18 INFO - blessings == 1.6 05:43:18 INFO - blobuploader == 1.2.4 05:43:18 INFO - docopt == 0.6.1 05:43:18 INFO - functools32 == 3.2.3-2 05:43:18 INFO - jsonschema == 2.5.1 05:43:18 INFO - manifestparser == 1.1 05:43:18 INFO - mozInstall == 1.13 05:43:18 INFO - mozcrash == 1.0 05:43:18 INFO - mozdebug == 0.1 05:43:18 INFO - mozdevice == 0.51 05:43:18 INFO - mozfile == 1.2 05:43:18 INFO - mozhttpd == 0.7 05:43:18 INFO - mozinfo == 0.10 05:43:18 INFO - mozleak == 0.1 05:43:18 INFO - mozlog == 3.5 05:43:18 INFO - moznetwork == 0.27 05:43:18 INFO - mozprocess == 0.25 05:43:18 INFO - mozprofile == 0.28 05:43:18 INFO - mozrunner == 6.13 05:43:18 INFO - mozscreenshot == 0.1 05:43:18 INFO - mozsystemmonitor == 0.3 05:43:18 INFO - moztest == 0.8 05:43:18 INFO - mozversion == 1.4 05:43:18 INFO - psutil == 3.1.1 05:43:18 INFO - requests == 1.2.3 05:43:18 INFO - wsgiref == 0.1.2 05:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:18 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:18 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 05:43:18 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 05:43:18 INFO - Using env: {'DISPLAY': ':0', 05:43:18 INFO - 'HOME': '/home/cltbld', 05:43:18 INFO - 'LANG': 'en_US.UTF-8', 05:43:18 INFO - 'LANGUAGE': 'en_US:en', 05:43:18 INFO - 'LOGNAME': 'cltbld', 05:43:18 INFO - 'MAIL': '/var/mail/cltbld', 05:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:18 INFO - 'MOZ_NO_REMOTE': '1', 05:43:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:18 INFO - 'NO_EM_RESTART': '1', 05:43:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:18 INFO - 'PWD': '/builds/slave/test', 05:43:18 INFO - 'SHELL': '/bin/bash', 05:43:18 INFO - 'SHLVL': '1', 05:43:18 INFO - 'TERM': 'linux', 05:43:18 INFO - 'TMOUT': '86400', 05:43:18 INFO - 'USER': 'cltbld', 05:43:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:18 INFO - '_': '/tools/buildbot/bin/python'} 05:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 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)) 05:43:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:43:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:43:19 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)) 05:43:19 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)) 05:43:19 INFO - Installing collected packages: simplejson 05:43:19 INFO - Running setup.py install for simplejson 05:43:19 INFO - building 'simplejson._speedups' extension 05:43:19 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 05:43:20 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 05:43:20 INFO - Successfully installed simplejson 05:43:20 INFO - Cleaning up... 05:43:20 INFO - Return code: 0 05:43:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:43:20 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')]} 05:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:43:20 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')]} 05:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:43:20 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 0x24ac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2674b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28199c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, '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': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', '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 05:43:20 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 05:43:20 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 05:43:20 INFO - Using env: {'DISPLAY': ':0', 05:43:20 INFO - 'HOME': '/home/cltbld', 05:43:20 INFO - 'LANG': 'en_US.UTF-8', 05:43:20 INFO - 'LANGUAGE': 'en_US:en', 05:43:20 INFO - 'LOGNAME': 'cltbld', 05:43:20 INFO - 'MAIL': '/var/mail/cltbld', 05:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:20 INFO - 'MOZ_NO_REMOTE': '1', 05:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:20 INFO - 'NO_EM_RESTART': '1', 05:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:20 INFO - 'PWD': '/builds/slave/test', 05:43:20 INFO - 'SHELL': '/bin/bash', 05:43:20 INFO - 'SHLVL': '1', 05:43:20 INFO - 'TERM': 'linux', 05:43:20 INFO - 'TMOUT': '86400', 05:43:20 INFO - 'USER': 'cltbld', 05:43:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:20 INFO - '_': '/tools/buildbot/bin/python'} 05:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:43:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:43:20 INFO - Cleaning up... 05:43:20 INFO - Return code: 0 05:43:20 INFO - Running post-action listener: _resource_record_post_action 05:43:20 INFO - Running post-action listener: _start_resource_monitoring 05:43:21 INFO - Starting resource monitoring. 05:43:21 INFO - [mozharness: 2017-10-04 12:43:21.005908Z] Finished create-virtualenv step (success) 05:43:21 INFO - [mozharness: 2017-10-04 12:43:21.006382Z] Running install step. 05:43:21 INFO - Running pre-action listener: _resource_record_pre_action 05:43:21 INFO - Running main action method: install 05:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:43:21 INFO - Reading from file tmpfile_stdout 05:43:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:43:21 INFO - Reading from file tmpfile_stdout 05:43:21 INFO - Output received: 05:43:21 INFO - Usage: mozinstall [options] installer 05:43:21 INFO - Options: 05:43:21 INFO - -h, --help show this help message and exit 05:43:21 INFO - -d DEST, --destination=DEST 05:43:21 INFO - Directory to install application into. [default: 05:43:21 INFO - "/builds/slave/test"] 05:43:21 INFO - --app=APP Application being installed. [default: firefox] 05:43:21 INFO - mkdir: /builds/slave/test/build/application 05:43:21 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'] 05:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:43:39 INFO - Reading from file tmpfile_stdout 05:43:39 INFO - Output received: 05:43:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:43:39 INFO - Running post-action listener: _resource_record_post_action 05:43:39 INFO - [mozharness: 2017-10-04 12:43:39.117406Z] Finished install step (success) 05:43:39 INFO - [mozharness: 2017-10-04 12:43:39.117657Z] Running setup-mitmproxy step. 05:43:39 INFO - Running pre-action listener: _resource_record_pre_action 05:43:39 INFO - Running main action method: setup_mitmproxy 05:43:39 INFO - Skipping: mitmproxy is not required 05:43:39 INFO - Running post-action listener: _resource_record_post_action 05:43:39 INFO - [mozharness: 2017-10-04 12:43:39.118855Z] Finished setup-mitmproxy step (success) 05:43:39 INFO - [mozharness: 2017-10-04 12:43:39.119077Z] Running run-tests step. 05:43:39 INFO - Running pre-action listener: _resource_record_pre_action 05:43:39 INFO - Running pre-action listener: _set_gcov_prefix 05:43:39 INFO - Running main action method: run_tests 05:43:39 WARNING - Try message not found. 05:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:43:39 INFO - Python 2.7.3 05:43:39 INFO - Return code: 0 05:43:39 INFO - grabbing minidump binary from tooltool 05:43:39 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')]} 05:43:39 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 0x2816d60>, '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 0x2817a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2817ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:43:39 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 05:43:39 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 05:43:39 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 05:43:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:43:39 INFO - Return code: 0 05:43:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:43:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:43:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:43:39 INFO - ENV: RUST_BACKTRACE is now full 05:43:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:43:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:43:39 INFO - Using env: {'DISPLAY': ':0', 05:43:39 INFO - 'HOME': '/home/cltbld', 05:43:39 INFO - 'LANG': 'en_US.UTF-8', 05:43:39 INFO - 'LANGUAGE': 'en_US:en', 05:43:39 INFO - 'LOGNAME': 'cltbld', 05:43:39 INFO - 'MAIL': '/var/mail/cltbld', 05:43:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:39 INFO - 'MOZ_NO_REMOTE': '1', 05:43:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:39 INFO - 'NO_EM_RESTART': '1', 05:43:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:39 INFO - 'PWD': '/builds/slave/test', 05:43:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:39 INFO - 'RUST_BACKTRACE': 'full', 05:43:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:43:39 INFO - 'SHELL': '/bin/bash', 05:43:39 INFO - 'SHLVL': '1', 05:43:39 INFO - 'TERM': 'linux', 05:43:39 INFO - 'TMOUT': '86400', 05:43:39 INFO - 'USER': 'cltbld', 05:43:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:39 INFO - '_': '/tools/buildbot/bin/python'} 05:43:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:43:39 INFO - mozversion application_buildid: 20171004091107 05:43:39 INFO - mozversion application_changeset: 933b30269777f718a14d2fc379e563a051b14618 05:43:39 INFO - mozversion application_display_name: Nightly 05:43:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:43:39 INFO - mozversion application_name: Firefox 05:43:39 INFO - mozversion application_remotingname: firefox 05:43:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:43:39 INFO - mozversion application_vendor: Mozilla 05:43:39 INFO - mozversion application_version: 58.0a1 05:43:39 INFO - mozversion platform_buildid: 20171004091107 05:43:39 INFO - mozversion platform_changeset: 933b30269777f718a14d2fc379e563a051b14618 05:43:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:43:39 INFO - mozversion platform_version: 58.0a1 05:43:39 INFO - using testdate: 1507121019 05:43:39 INFO - actual date: 1507121019 05:43:39 INFO - starting webserver on 'localhost:60209' 05:43:39 INFO - SUITE-START | Running 2 tests 05:43:39 INFO - TEST-START | dromaeo_css 05:43:39 INFO - Initialising browser for dromaeo_css test... 05:43:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60209/getInfo.html -profile /tmp/tmpkrB0b9/profile 05:43:39 INFO - TEST-INFO | started process 28845 (/builds/slave/test/build/application/firefox/firefox http://localhost:60209/getInfo.html) 05:43:44 INFO - TEST-INFO | 28845: exit 0 05:43:44 INFO - Browser initialized. 05:43:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:43:44 INFO - Using env: {'DISPLAY': ':0', 05:43:44 INFO - 'HOME': '/home/cltbld', 05:43:44 INFO - 'JSGC_DISABLE_POISONING': '1', 05:43:44 INFO - 'LANG': 'en_US.UTF-8', 05:43:44 INFO - 'LANGUAGE': 'en_US:en', 05:43:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 05:43:44 INFO - 'LOGNAME': 'cltbld', 05:43:44 INFO - 'MAIL': '/var/mail/cltbld', 05:43:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:43:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:43:44 INFO - 'MOZ_CRASHREPORTER': '1', 05:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:43:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 05:43:44 INFO - 'MOZ_NO_REMOTE': '1', 05:43:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:43:44 INFO - 'NO_EM_RESTART': '1', 05:43:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:43:44 INFO - 'PWD': '/builds/slave/test', 05:43:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:43:44 INFO - 'RUST_BACKTRACE': 'full', 05:43:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:43:44 INFO - 'SHELL': '/bin/bash', 05:43:44 INFO - 'SHLVL': '1', 05:43:44 INFO - 'STYLO_FORCE_DISABLED': '1', 05:43:44 INFO - 'TERM': 'linux', 05:43:44 INFO - 'TMOUT': '86400', 05:43:44 INFO - 'USER': 'cltbld', 05:43:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 05:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:43:44 INFO - '_': '/tools/buildbot/bin/python'} 05:43:44 INFO - TEST-INFO | started process 29116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkrB0b9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:45 INFO - PID 29116 | 05:43:45 INFO - PID 29116 | (/builds/slave/test/build/application/firefox/firefox:29166): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:43:45 INFO - PID 29116 | 05:43:55 INFO - PID 29116 | RSS: Main: 147914752 05:43:55 INFO - PID 29116 | 05:46:53 INFO - PID 29116 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60209/tests/dromaeo/cssquery-ext.html) 05:46:54 INFO - PID 29116 | RSS: Main: 144171008 05:46:54 INFO - PID 29116 | 05:49:55 INFO - PID 29116 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-ext.html (next: http://localhost:60209/tests/dromaeo/cssquery-jquery.html) 05:49:56 INFO - PID 29116 | RSS: Main: 145256448 05:49:56 INFO - PID 29116 | 05:52:57 INFO - PID 29116 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60209/tests/dromaeo/cssquery-mootools.html) 05:52:58 INFO - PID 29116 | RSS: Main: 144596992 05:52:58 INFO - PID 29116 | 05:56:00 INFO - PID 29116 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60209/tests/dromaeo/cssquery-prototype.html) 05:56:00 INFO - PID 29116 | RSS: Main: 146214912 05:56:00 INFO - PID 29116 | 05:59:03 INFO - PID 29116 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60209/tests/dromaeo/cssquery-yui.html) 05:59:04 INFO - PID 29116 | RSS: Main: 149540864 05:59:04 INFO - PID 29116 | 06:02:05 INFO - PID 29116 | Cycle 1(1): loaded http://localhost:60209/tests/dromaeo/cssquery-yui.html (next: http://localhost:60209/tests/dromaeo/cssquery-dojo.html) 06:02:06 INFO - PID 29116 | RSS: Main: 150634496 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | __start_tp_report 06:02:06 INFO - PID 29116 | _x_x_mozilla_page_load 06:02:06 INFO - PID 29116 | _x_x_mozilla_page_load_details 06:02:06 INFO - PID 29116 | |i|pagename|runs| 06:02:06 INFO - PID 29116 | |0;dojo.html;3876.767393956363;3882.223555288943;3892.318844202264;3909.6676782473487;3920.647141757241;6248.15649887265;6256.749730010805;6294.685265736712;6310.7791227307;6375.23497180339;6316.27362853272;6330.050492426139;6331.968340158304;6334.239891213049;6355.777547785829;5545.1682247662975;5688.232088668018;5690.516306113965;5753.827385178452;5761.884762304751;5671.8014869479575;5704.629199102066;5746.310442746855;5824.068149096145;5853.473187413132;5553.527950124244;5645.971770141164;5658.34928983164;5738.598298119134;5766.423357664242;5667.3482549506925;5668.121441176624;5733.054046082391;5734.139879018139;5770.942290577124;5582.665040097607;5599.272094627672;5630.352509461423;5636.15457681347;5718.456746609066;6284.214473190851;6297.811065668037;6303.464205542535;6319.33646967071;6350.872982540323;6905.654717264117;6912.723491060352;6923.273056329063;6930.683170197697;6937.063496427968;6854.897176542356;6865.9313406865795;6878;6948.895766563505;6969.721211151548;6279.026750853625;6288.151099601587;6292.150559674477;6312.842178945517;6316.905246421307;6724.865502689919;6963.059986901805;6989.30106989297;7034.788956331318;7098.148222213367;6780.660966951633;6795.864082718318;6845.657717114124;6871.415929645936;6879.965600172067;6918.930810691829;6936.861262774716;6985.336393042653;6996.160460744743;7036.6481675916;6729.798106056728;6797.694103765342;6827.726890924407;6835.4189893859575;6839.555428897106;6766.966165169143;6840.794776156723;6845.041694162821;6861.176658800976;6861.93639985803;4931.876703082452;4973.179425394842;4975.726335051607;4994.700317980933;5013.523715247045;4467.530909254481;4516.864494065183;4536.727796332165;4591.449026116888;4596.448426188812;6192.504599632109;6195.938040619536;6253.53098517613;6264.655443950626;6269.811905642838;6721.227058888193;6761.154855643044;6800.455963522906;6826.419754320938;6829.863402731918;6268.122462855204;6270.717817698214;6279.497640188774;6279.843003924847;6331.556791024676;5458.863528411742;5521.668699878021;5533.557315414838;5534.252875861787;5535.8892822144135;7126.251743566851;7153.391961683211;7166.892496612555;7253.455990800711;7266.600336981517;6722.764703235363;6752.729890804313;6823.488238382042;6824.692888819915;6837.008633748178;7145.321194486515;7180.5691658500655;7183.604901730455;7213.278672132745;7230.385417239593;6753.3246675332075;6791.830204244736;6801;6873.312668733087;6879.484038697017;6777.288384719731;6842.521023528305;6860.794176174722;6949.096617439701;6950.687219075053;6614.867702645824;6634.867302654016;6637.966810165918;6638.502112341497;6639.435647969976;6504.837379065372;6603.669816509251;6610.669466526559;6615.768448104293;6661.700223489857;6559.7376104955265;6573.309802470863;6597.934020659732;6613.107230523818;6625.801225963229;6637.966810165918;6646.8005959821285;6711.597304161766;6730.158730158731;6735.898961515483;6331.620102793847;6431.260405053479;6435;6531.510136739668;6561 06:02:06 INFO - PID 29116 | |1;ext.html;951.3816019587267;962.5524131278954;983.2478154212027;1017.7303014701101;1020.2959957629231;43255.78372108139;45338.54661453389;45696;45817;45850.312245316345;43478.34782478266;46113.53886461134;46980.29529557059;47011.29483057757;47078.76460617692;8696.73909782706;8848.5575721214;8855.15875991783;8863.95568022159;8864.246539044158;8565.48607083577;8807.295416366675;8809.295256379473;8822;8825.823483530325;8786.253168480687;8825.161609647106;8855.73432797017;8859.512726800023;8866.911330886705;8722.084181160983;8791;8794.956025219897;8809.559522023874;8812.559372031405;8599.44103633268;8665.566721663892;8699.260562852101;8703;8734.12658734128;41769.373459398135;41988.790056049525;42067.158656826694;42072;42099.789501052604;3812.618738126193;3846.7499612525376;3846.769193848378;3846.9807650961848;3849.0377405648587;32297.838510807294;32619.51070733941;33076.503852442234;33192.50211246833;33216.1695957603;5509.944900550983;5607.52336051432;5628.493435590816;5675.772969081232;5677.034904066319;226728.8663556688;227132;227276;227783;227866;53137.468625314024;53794;53950.73024634852;54019.408350290665;54030.729846350514;56756.71621641865;57371.42628573744;57386;57409.425905740405;57459;17499.475015749293;17634.647307053787;17635.294588216584;17651.293948242183;17656.293748250184;14330.21183834899;14368.281585920662;14369.425222991173;14384.928075359765;14387.568372948828;13691.452341906212;13854.099483533539;13940.86059139416;13976.580702578938;14110.365033573515;5334.426344228462;5349.893002139936;5395.73021348931;5461.1262198048125;5488.615796894259;1056.4453661827602;1084.5878566144972;1093.8085834978847;1104.276698762312;1106.4136007915818;25531.36171595688;25825.354366140997;25891.611625825626;26049.609255861178;26223.737762622128;1183.8398369597842;1187.5215356880567;1210.8849659282355;1216.7688139253514;1221.6396163131897;13330.200187988752;13595.52415665447;13642.976776741783;13713.931430342784;13787.310634468437;287015;288012;288462;289182;289685;53285.7335713319;55107;60332;61432.69283653642;61762.38237617656;1559.5555266748922;1562.1798555758319;1568.4902406717863;1571.2379495944458;1575.243882936197;31173;31365.215869603442;32011.839940800146;32285.838570806995;32388.514172286963;43174.78412607917;43239.35140972825;43282.35076473918;43347.783261083496;43372.783136084116;251119;252135;252642;252793;254148;37245.81377093206;38221.4266786004;38403.615963840006;38675;38682.806585968014;47327.870245838334;48376.758116209196;48687.513124869714;48813;48910;35660.10849728777;35884.64115358813;36143.81928090343;36193.63806361903;36307.63692363042;35489.467657984635;35724.10689732777;35729.46405803967;36155.81922090373;36480;41984.58015419929;42673;42806.78596607121;43384.13231735284;43388.783056085784;34570.13574660654;34673.30653386968;35087.82456087703;35177.29645407027;35986.64013359938;25865.353366165997;25888.093916712824;26198.214053578424;26543.86728066347;26683.33291667724 06:02:06 INFO - PID 29116 | |2;jquery.html;628.2021832273016;630.9558330916838;639.9520035997299;643.4305639509033;653.705832375431;22872.65691014636;23415.1804686836;23521.529569408645;24264.029438822447;24338.39154021148;23095.884520577416;23565.882170589124;23569.5286094278;23572.88213558934;23598.5280294394;6618.8676226475445;6738.225104113017;6891.7932462025965;6898.793036208922;6905.413039891615;6801.93198068018;6805.727770889159;6834.624095674761;6844.31556844314;6844.589324640513;6744.561603495782;6756.851335273015;6774.5257831951785;6795.93204067958;6803.217629972567;6731.831704207385;6772.356626120511;6775.288594697559;6777.390034896883;6778.627175505345;6322.968385158045;6339.175907132089;6349.142865713162;6361.650109243989;6361.968190159066;29036.27409314763;31421.528677069862;31486.055418337488;31622.683773162204;31710.841445792623;2256.2216035467736;2309.434188623781;2313.34069790109;2316.224064938248;2317.154238702878;19978.400647980583;20254.69617955732;20549.794502054938;20661.4834629134;20758.896205519028;2516.7357427470033;2574.8197626166175;2607.296030071889;2612.0988259050596;2617.7251388604113;146093;154021.22989385095;157045;164073;164610.9999999988;15222.238888055554;16125.758113628304;16178.75731864023;16683.83316166847;17174.141292935303;26663.33341666474;26689.398636081896;26783.660816959073;26805.061822836105;26845.463090738074;11008.174386921013;11010.064144547643;11095.722606934729;11245.212835101627;11256.831147532794;10006.949965250127;10066.043725846033;10264.64073757415;10284.331518451278;10327.380357178594;9758.316917815684;10103.545340459697;10157.409860485528;10213.846792298122;10219;2872.5116730155924;2883.163882474059;2942.367391010943;2952.247176969902;3008.353204061137;1025.17985611512;1055.3984228989557;1064.2975636080305;1069.9144068474504;1079.8110330692098;20538;20720.378388648365;20731.792682073286;21041.579168416545;21362.14551417957;1105.8451816745662;1118.8769235384102;1120.6245907620876;1124.291696231369;1131.6944425005202;11426.542938282375;11459.255148415326;11475.254108482923;11537.250078745023;11615.709607259887;628912;632505;648077;650362;676696;125060;129361;129846;132220;136837;1118.3904771899333;1163.947622356996;1228.1648479034343;1231.2612432540584;1295.164618820874;22530;22574.20990265333;22755;22780.316590502312;22850.200242991414;62524;63330.36669633429;63548;65350.34649653633;65683.67158164179;81478;82453.17546824455;82630;82776;83183;15568.455104071303;16074.43739469113;16142.354305828105;16150.111743853731;16167;24250.272491825275;24343.634845477685;24387.75612243855;24479.26562203137;24584;19930.60138797187;19950.90024549926;20017;20089.598208036048;20298.492537686085;17567.297308107532;17717.20272587711;17749.201285941905;18136.909315453337;18161.636767264845;20103.89948050309;20251;20261.189552418327;20437.69343459879;20466.795332047084;15634.843651563793;15816.841831581536;15841.366345346518;15947.44183953556;15981.920090399939;18586.44240672782;18725.15736791875;18904.338348157748;18923.337683181024;18968.336108236144 06:02:06 INFO - PID 29116 | |3;mootools.html;1451.3614009835674;1518.954431367058;1530.762731776575;1536.7694845773133;1540.6764579438318;16531.256093475793;17325;17345.04602246876;17350.652986940255;17377.30490780367;16899.324027038936;17002;17018.149092545355;17096.230669619865;17140.914295428505;2895;2953.394554116406;2963.096255642028;2965.9258518537104;2972.895948641798;2922.7515661168827;2950.498415269409;2952.8483891282417;2953.911382658513;2961.452131355706;2899.4201159768027;2970.1683528612025;2972.093511478998;2983.254186453387;2997;2449.7060352757603;2477.2196758021255;2510.4853505031424;2511.3470497670555;2512.6733524641772;2705.6076868853906;2747.7939154563487;2982.2693440107096;2989.237744375192;2990.7158819912074;16670.58323541909;16796;16802.243899024572;16821.495355139366;16854.073025983565;8584.527850968194;8801.867971980426;8822.735317940407;8832.8675069874;8844.11558844117;5748.45389687979;5913.113033045035;5967.9701601491715;6009.789657362015;6030.758769649209;2196.428928478591;2203.0747086223823;2212.15937943582;2216.822654187661;2264.864108153516;30057.549136762966;30180.396392072034;30370.240743981358;30437.23906902323;31011.84494077515;7656.234376562411;7744.49660772048;7813.960930195312;7828;7929.167437418988;19418;19437.902810485855;19474.22103115888;19534.902325488565;19559.413217603495;8836.381453298207;8976.147266009719;9065.048169942193;9066.138716821892;9067.274618030673;8046.919530804734;8085;8116.918830811735;8215;8221.712240071569;6045.758169673251;6059.121427393004;6061.969690151521;6080.543959203077;6168.537359698041;1754.2369069454828;1758.709812880886;1806.9186886590135;1807.9276828926959;1808.032702504154;910.299069716328;915.8900931888217;927.3879239701764;940.7130825098411;951.923846092311;8072.515649061075;8113.310368618733;8121.75634730959;8144.674213031531;8191.344692424592;759.8822182561712;790.5612385126195;798.7523867601062;811.8701007838836;822.8930239068883;5058.873528161752;5242.9737851311265;6064.514838812885;6102.016844525547;6301.6534090625455;24156.275311740676;24325.270241892773;25527.48945021089;25695.48609027809;25806.741932580808;24054.7594524056;24356.391090222885;24698.629520557206;24891;24909.750902490745;11237.21339506243;11237.269577477438;12064.336461494526;12114.15200935926;12338.938305308417;10288.331258468175;10308.12380947628;10324.43215623148;10392.272540922062;10673;20557.280495182596;20616.48458788542;20777.58444831065;20879.791202088392;21142;21547.353579392642;21557;21560.67658985148;21879.234226801986;22038.228661996753;12471.064670149957;12598;12643.114981951176;12700.936495317465;12862.614121576367;15228.390864365301;15449.922750386626;15450.613734656723;15455.922720386327;15458.072515649097;12636.87363126357;12639.747205056032;12830.358482076046;12836.294003829878;13138;11901.285922844658;12056.156069075432;12298.385080745747;12406.193597416139;12462.189957652723;11087.390193539433;11092.057175140204;11100.5559777608;11156.944215278872;11160.330380177214;7968.402369822403;7979.321757650432;7998.760037198894;8075.838483230185;8093.514389136435;7726.652300646372;7743.7676869694;7787.338076263581;7800.531968081933;7896.84206315882 06:02:06 INFO - PID 29116 | |4;prototype.html;552.9668219906804;564.6386312759834;579.149616973769;583.361219464686;585.794971759884;6296.811095667126;6300.527460440474;6321.6523091229965;6368;6436.452901503366;6179.9691001544925;6280.874382512347;6281.968590157055;6297.874042519147;6323.577195131104;5115.462876397981;5143.3570803649545;5159.277701121846;5179.611529135311;5205;5022.949770502303;5074.492550744914;5109.591232701375;5137.049645815536;5148.974255128719;5035.823746168885;5069.949300506984;5082.542571168594;5102.668326558781;5118.692878427288;5091.949080509203;5103.2855400244;5117.8464646060675;5129.12804823181;5148.716820574867;4641.559051890065;4675.836345727883;4681.789319480631;4722.693024953367;4727.125481785846;6144.78493252734;6213.56505044647;6275.8744825103695;6292.276388215368;6312.043266587372;5936.109583562457;5956.344802071769;5965.28416590012;5972.223610930551;5975.25309336333;6665.266820649773;6682.83292917676;6750.561213521106;6760.6619669016845;6767.560108592926;4985.401751789772;5132.563732082777;5197.454267301954;5233.325335892516;5245.160774276097;6772.966135169293;6880.58716477013;6966.9651651741415;6972.616506092163;7033.331833475811;5311.946880531223;5347.919781203285;5351.759170837322;5352.518273355417;5383.977044361559;5394.3796463406425;5426.864328391822;5438.864028399322;5451.209574611738;5481.342238931354;5952.553558483131;5987.790427335022;6000.099985002197;6013.639181649115;6027.156198132265;6714.194296684332;6758.837172104978;6773.729050837911;6802.863942721118;6849.630073985223;1821.9614819552992;1848.704207326848;1855.7844611779306;1880.3982725527974;1899.7340372347883;1276.9872301276869;1350.210127075652;1351.1082685427766;1355.3629793996806;1369.4111532041318;6078.0579010252595;6146.6004709693725;6164.4760195383;6178.969105154535;6281.59169653971;6481.28705842357;6568.146141001735;6676.666166691646;6694.397504224643;6731.124953756078;6112.449879510866;6136.938630613726;6140.17107690465;6160.784372546939;6162.506999440034;3504.5444092267844;3540.1857572757895;3540.6105328413855;3587.408077667208;3599.190182208982;7025.859482810315;7040.577565346096;7082.327178917994;7119.501634885612;7120.4690991436055;6988.44092472601;7022.719091236396;7024.894626580605;7050.823729406703;7083.539569927938;7003.26465721092;7003.649817509104;7009.264027277062;7193.172785129673;7204;6775.898361524482;6802.591844489149;6821.795346139624;6832.385085342343;6866.382025617719;6676.230798838409;6755.42578880781;6773.288804675438;6784.321567843176;6831.453483721191;6889.311068893071;7039.9296007039275;7184.1738200105565;7213.350798428167;7229.710811567689;5332.20016997438;5387.542058924879;5390.897549955599;5393.352797664305;5407.405185429679;6535.607863528204;6708.396244338033;6817.693203805741;6865.656717164222;6892.138482689664;6312.581193164711;6476.70854811544;6572.967135164294;6593.175853018372;6643.40209381158;6469.385408386196;6501.544891857525;6505.73977040932;6544.28012918569;6625.238097618835;6342.651154186379;6388.872222555616;6454.805860915746;6466.4503517201565;6494.415502604788;6624.701888414937;6657.667116644246;6658.866822663423;6726.327367263235;6742.460603151638;6436.227652681709;6472.611643301417;6488.12410324619;6567.835804104936;6572.737090516326 06:02:06 INFO - PID 29116 | |5;yui.html;958.9520523973799;985.7278971969611;985.9014098590142;990.4750482244413;1015.6089905386426;20902.268420605284;21980.120795168175;22013.66979495305;22017.779822201774;22024.669629955544;19577.314793982212;20074.698879516818;20540.38378848633;20711.896440517816;20718.792812071875;1067.8558394616725;1102.2339474065527;1103.5806393570433;1103.7957977774097;1109.8612673415823;1047.261680515235;1081.9621313254038;1088.6733979806027;1104.2932523185168;1105.9889401105966;1157.8668453127914;1161.7037655397862;1162.0819552553473;1170.180873388627;1171.1801738782885;1090.4711215060688;1166.7433164703752;1166.8249762535602;1167.1713083710576;1169.7017260598577;812.2608426332068;818.4925346285341;818.7175424478545;820.8071103290722;820.9220124088203;21439.249626263005;21527.569448611095;21565.892170539046;21570.245041423474;21611.459713507287;22879;23705.407364815845;23870.76129238703;23889;23918.402039948967;18484.72272915907;19076.904615476833;19157.521061973424;19206.711899321523;19251.90374048135;4001.9399709004388;4023.7988100595144;4032.6370626643447;4037.1118353962083;4037.4751282333405;169913.15043424827;170177;170759;170961;171799.28200718082;17564.5608859777;17783.110844457726;17956.730649040273;17971.820281797278;18130.818691813176;34793;35387.64612353895;35620.28759424849;35975.28049439049;36003.4599481008;7950.681972721027;8082.9191708083345;8119.715809946623;8140.023197216372;8151.470154439942;4212.957870421256;4314.460692413449;4354.804033818423;4381.058072514425;4411.691181617321;6177.382261773877;6300.401461861115;6303.149074874925;6303.401176888188;6308.589941653778;1136.1195073817858;1158.478684591937;1181.8050021746487;1183.0535571542732;1191.1721353659125;762.9580373079534;771.3636250093583;772.563501621582;782.9217078292126;793.2979313307765;12529.721700205959;12660.683482913;13149.276789776653;13239.669008274677;13645;747.7457664394132;753.7701001194579;757.443279189795;774.0285941143828;776.5379599138504;6214.291069955799;6237.500999919996;6276.089966954766;6319.778807741707;6382.106505089291;159906.20046899925;161654.1917290406;162555;164436;170112;147579;148670;148725;150556;151030;126120;130615.34692326668;131582;131831;132320.99999999808;11441.656750297505;11448.026917711755;11537.769244615229;12049.33728644898;12209.938950305192;61658.69170654118;62644.686776565824;63351.683241583494;63641.36358636354;65529.017064743115;77422.61288693521;78105.60947195228;79598.20401795908;80564;80608;17246.568835779206;17891.73162402591;18148.546286342946;18206.45380638583;18214.81785182184;16971.490855274362;17222.536084432963;17240.568985775455;17444;17502.73745893838;15357;15650.608734781721;15723.304859180187;15745.291461884013;15867.603309917344;15661.138637375054;15703.371865125268;15875.364985400454;15897.364105436116;16035.599110022344;15089.54731358061;15120.470783522524;15218.16300103505;15262.3895044197;15376.308066136828;11726.179167458537;11777.35224562623;11906.166568340133;11936.641900742992;12333.93833030865;11363.715907102058;11558.364289964133;11602.593909213138;11642.233273642254;11774.293542387484 06:02:06 INFO - PID 29116 | __end_tp_report 06:02:06 INFO - PID 29116 | __start_cc_report 06:02:06 INFO - PID 29116 | _x_x_mozilla_cycle_collect,268 06:02:06 INFO - PID 29116 | __end_cc_report 06:02:06 INFO - PID 29116 | __startTimestamp1507122126003__endTimestamp 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | ------- Summary: start ------- 06:02:06 INFO - PID 29116 | Number of tests: 6 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | [#0] dojo.html Cycles:165 Average:6304.16 Median:6573.31 stddev:756.58 (11.5%) stddev-sans-first:734.54 06:02:06 INFO - PID 29116 | Values: 3876.8 3882.2 3892.3 3909.7 3920.6 6248.2 6256.7 6294.7 6310.8 6375.2 6316.3 6330.1 6332.0 6334.2 6355.8 5545.2 5688.2 5690.5 5753.8 5761.9 5671.8 5704.6 5746.3 5824.1 5853.5 5553.5 5646.0 5658.3 5738.6 5766.4 5667.3 5668.1 5733.1 5734.1 5770.9 5582.7 5599.3 5630.4 5636.2 5718.5 6284.2 6297.8 6303.5 6319.3 6350.9 6905.7 6912.7 6923.3 6930.7 6937.1 6854.9 6865.9 6878.0 6948.9 6969.7 6279.0 6288.2 6292.2 6312.8 6316.9 6724.9 6963.1 6989.3 7034.8 7098.1 6780.7 6795.9 6845.7 6871.4 6880.0 6918.9 6936.9 6985.3 6996.2 7036.6 6729.8 6797.7 6827.7 6835.4 6839.6 6767.0 6840.8 6845.0 6861.2 6861.9 4931.9 4973.2 4975.7 4994.7 5013.5 4467.5 4516.9 4536.7 4591.4 4596.4 6192.5 6195.9 6253.5 6264.7 6269.8 6721.2 6761.2 6800.5 6826.4 6829.9 6268.1 6270.7 6279.5 6279.8 6331.6 5458.9 5521.7 5533.6 5534.3 5535.9 7126.3 7153.4 7166.9 7253.5 7266.6 6722.8 6752.7 6823.5 6824.7 6837.0 7145.3 7180.6 7183.6 7213.3 7230.4 6753.3 6791.8 6801.0 6873.3 6879.5 6777.3 6842.5 6860.8 6949.1 6950.7 6614.9 6634.9 6638.0 6638.5 6639.4 6504.8 6603.7 6610.7 6615.8 6661.7 6559.7 6573.3 6597.9 6613.1 6625.8 6638.0 6646.8 6711.6 6730.2 6735.9 6331.6 6431.3 6435.0 6531.5 6561.0 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | [#1] ext.html Cycles:180 Average:44194.63 Median:21125.18 stddev:66868.08 (316.5%) stddev-sans-first:66976.84 06:02:06 INFO - PID 29116 | Values: 951.4 962.6 983.2 1017.7 1020.3 43255.8 45338.5 45696.0 45817.0 45850.3 43478.3 46113.5 46980.3 47011.3 47078.8 8696.7 8848.6 8855.2 8864.0 8864.2 8565.5 8807.3 8809.3 8822.0 8825.8 8786.3 8825.2 8855.7 8859.5 8866.9 8722.1 8791.0 8795.0 8809.6 8812.6 8599.4 8665.6 8699.3 8703.0 8734.1 41769.4 41988.8 42067.2 42072.0 42099.8 3812.6 3846.7 3846.8 3847.0 3849.0 32297.8 32619.5 33076.5 33192.5 33216.2 5509.9 5607.5 5628.5 5675.8 5677.0 226728.9 227132.0 227276.0 227783.0 227866.0 53137.5 53794.0 53950.7 54019.4 54030.7 56756.7 57371.4 57386.0 57409.4 57459.0 17499.5 17634.6 17635.3 17651.3 17656.3 14330.2 14368.3 14369.4 14384.9 14387.6 13691.5 13854.1 13940.9 13976.6 14110.4 5334.4 5349.9 5395.7 5461.1 5488.6 1056.4 1084.6 1093.8 1104.3 1106.4 25531.4 25825.4 25891.6 26049.6 26223.7 1183.8 1187.5 1210.9 1216.8 1221.6 13330.2 13595.5 13643.0 13713.9 13787.3 287015.0 288012.0 288462.0 289182.0 289685.0 53285.7 55107.0 60332.0 61432.7 61762.4 1559.6 1562.2 1568.5 1571.2 1575.2 31173.0 31365.2 32011.8 32285.8 32388.5 43174.8 43239.4 43282.4 43347.8 43372.8 251119.0 252135.0 252642.0 252793.0 254148.0 37245.8 38221.4 38403.6 38675.0 38682.8 47327.9 48376.8 48687.5 48813.0 48910.0 35660.1 35884.6 36143.8 36193.6 36307.6 35489.5 35724.1 35729.5 36155.8 36480.0 41984.6 42673.0 42806.8 43384.1 43388.8 34570.1 34673.3 35087.8 35177.3 35986.6 25865.4 25888.1 26198.2 26543.9 26683.3 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | [#2] jquery.html Cycles:180 Average:41350.18 Median:12415.22 stddev:108084.87 (870.6%) stddev-sans-first:108344.83 06:02:06 INFO - PID 29116 | Values: 628.2 631.0 640.0 643.4 653.7 22872.7 23415.2 23521.5 24264.0 24338.4 23095.9 23565.9 23569.5 23572.9 23598.5 6618.9 6738.2 6891.8 6898.8 6905.4 6801.9 6805.7 6834.6 6844.3 6844.6 6744.6 6756.9 6774.5 6795.9 6803.2 6731.8 6772.4 6775.3 6777.4 6778.6 6323.0 6339.2 6349.1 6361.7 6362.0 29036.3 31421.5 31486.1 31622.7 31710.8 2256.2 2309.4 2313.3 2316.2 2317.2 19978.4 20254.7 20549.8 20661.5 20758.9 2516.7 2574.8 2607.3 2612.1 2617.7 146093.0 154021.2 157045.0 164073.0 164611.0 15222.2 16125.8 16178.8 16683.8 17174.1 26663.3 26689.4 26783.7 26805.1 26845.5 11008.2 11010.1 11095.7 11245.2 11256.8 10006.9 10066.0 10264.6 10284.3 10327.4 9758.3 10103.5 10157.4 10213.8 10219.0 2872.5 2883.2 2942.4 2952.2 3008.4 1025.2 1055.4 1064.3 1069.9 1079.8 20538.0 20720.4 20731.8 21041.6 21362.1 1105.8 1118.9 1120.6 1124.3 1131.7 11426.5 11459.3 11475.3 11537.3 11615.7 628912.0 632505.0 648077.0 650362.0 676696.0 125060.0 129361.0 129846.0 132220.0 136837.0 1118.4 1163.9 1228.2 1231.3 1295.2 22530.0 22574.2 22755.0 22780.3 22850.2 62524.0 63330.4 63548.0 65350.3 65683.7 81478.0 82453.2 82630.0 82776.0 83183.0 15568.5 16074.4 16142.4 16150.1 16167.0 24250.3 24343.6 24387.8 24479.3 24584.0 19930.6 19950.9 20017.0 20089.6 20298.5 17567.3 17717.2 17749.2 18136.9 18161.6 20103.9 20251.0 20261.2 20437.7 20466.8 15634.8 15816.8 15841.4 15947.4 15981.9 18586.4 18725.2 18904.3 18923.3 18968.3 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | [#3] mootools.html Cycles:180 Average:10456.35 Median:2512.01 stddev:7644.55 (304.3%) stddev-sans-first:7636.06 06:02:06 INFO - PID 29116 | Values: 1451.4 1519.0 1530.8 1536.8 1540.7 16531.3 17325.0 17345.0 17350.7 17377.3 16899.3 17002.0 17018.1 17096.2 17140.9 2895.0 2953.4 2963.1 2965.9 2972.9 2922.8 2950.5 2952.8 2953.9 2961.5 2899.4 2970.2 2972.1 2983.3 2997.0 2449.7 2477.2 2510.5 2511.3 2512.7 2705.6 2747.8 2982.3 2989.2 2990.7 16670.6 16796.0 16802.2 16821.5 16854.1 8584.5 8801.9 8822.7 8832.9 8844.1 5748.5 5913.1 5968.0 6009.8 6030.8 2196.4 2203.1 2212.2 2216.8 2264.9 30057.5 30180.4 30370.2 30437.2 31011.8 7656.2 7744.5 7814.0 7828.0 7929.2 19418.0 19437.9 19474.2 19534.9 19559.4 8836.4 8976.1 9065.0 9066.1 9067.3 8046.9 8085.0 8116.9 8215.0 8221.7 6045.8 6059.1 6062.0 6080.5 6168.5 1754.2 1758.7 1806.9 1807.9 1808.0 910.3 915.9 927.4 940.7 951.9 8072.5 8113.3 8121.8 8144.7 8191.3 759.9 790.6 798.8 811.9 822.9 5058.9 5243.0 6064.5 6102.0 6301.7 24156.3 24325.3 25527.5 25695.5 25806.7 24054.8 24356.4 24698.6 24891.0 24909.8 11237.2 11237.3 12064.3 12114.2 12338.9 10288.3 10308.1 10324.4 10392.3 10673.0 20557.3 20616.5 20777.6 20879.8 21142.0 21547.4 21557.0 21560.7 21879.2 22038.2 12471.1 12598.0 12643.1 12700.9 12862.6 15228.4 15449.9 15450.6 15455.9 15458.1 12636.9 12639.7 12830.4 12836.3 13138.0 11901.3 12056.2 12298.4 12406.2 12462.2 11087.4 11092.1 11100.6 11156.9 11160.3 7968.4 7979.3 7998.8 8075.8 8093.5 7726.7 7743.8 7787.3 7800.5 7896.8 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | [#4] prototype.html Cycles:180 Average:5703.48 Median:6287.12 stddev:1572.66 (25.0%) stddev-sans-first:1528.81 06:02:06 INFO - PID 29116 | Values: 553.0 564.6 579.1 583.4 585.8 6296.8 6300.5 6321.7 6368.0 6436.5 6180.0 6280.9 6282.0 6297.9 6323.6 5115.5 5143.4 5159.3 5179.6 5205.0 5022.9 5074.5 5109.6 5137.0 5149.0 5035.8 5069.9 5082.5 5102.7 5118.7 5091.9 5103.3 5117.8 5129.1 5148.7 4641.6 4675.8 4681.8 4722.7 4727.1 6144.8 6213.6 6275.9 6292.3 6312.0 5936.1 5956.3 5965.3 5972.2 5975.3 6665.3 6682.8 6750.6 6760.7 6767.6 4985.4 5132.6 5197.5 5233.3 5245.2 6773.0 6880.6 6967.0 6972.6 7033.3 5311.9 5347.9 5351.8 5352.5 5384.0 5394.4 5426.9 5438.9 5451.2 5481.3 5952.6 5987.8 6000.1 6013.6 6027.2 6714.2 6758.8 6773.7 6802.9 6849.6 1822.0 1848.7 1855.8 1880.4 1899.7 1277.0 1350.2 1351.1 1355.4 1369.4 6078.1 6146.6 6164.5 6179.0 6281.6 6481.3 6568.1 6676.7 6694.4 6731.1 6112.4 6136.9 6140.2 6160.8 6162.5 3504.5 3540.2 3540.6 3587.4 3599.2 7025.9 7040.6 7082.3 7119.5 7120.5 6988.4 7022.7 7024.9 7050.8 7083.5 7003.3 7003.6 7009.3 7193.2 7204.0 6775.9 6802.6 6821.8 6832.4 6866.4 6676.2 6755.4 6773.3 6784.3 6831.5 6889.3 7039.9 7184.2 7213.4 7229.7 5332.2 5387.5 5390.9 5393.4 5407.4 6535.6 6708.4 6817.7 6865.7 6892.1 6312.6 6476.7 6573.0 6593.2 6643.4 6469.4 6501.5 6505.7 6544.3 6625.2 6342.7 6388.9 6454.8 6466.5 6494.4 6624.7 6657.7 6658.9 6726.3 6742.5 6436.2 6472.6 6488.1 6567.8 6572.7 06:02:06 INFO - PID 29116 | 06:02:06 INFO - PID 29116 | [#5] yui.html Cycles:180 Average:30137.11 Median:17964.28 stddev:46940.10 (261.3%) stddev-sans-first:47020.65 06:02:06 INFO - PID 29116 | Values: 959.0 985.7 985.9 990.5 1015.6 20902.3 21980.1 22013.7 22017.8 22024.7 19577.3 20074.7 20540.4 20711.9 20718.8 1067.9 1102.2 1103.6 1103.8 1109.9 1047.3 1082.0 1088.7 1104.3 1106.0 1157.9 1161.7 1162.1 1170.2 1171.2 1090.5 1166.7 1166.8 1167.2 1169.7 812.3 818.5 818.7 820.8 820.9 21439.2 21527.6 21565.9 21570.2 21611.5 22879.0 23705.4 23870.8 23889.0 23918.4 18484.7 19076.9 19157.5 19206.7 19251.9 4001.9 4023.8 4032.6 4037.1 4037.5 169913.2 170177.0 170759.0 170961.0 171799.3 17564.6 17783.1 17956.7 17971.8 18130.8 34793.0 35387.6 35620.3 35975.3 36003.5 7950.7 8082.9 8119.7 8140.0 8151.5 4213.0 4314.5 4354.8 4381.1 4411.7 6177.4 6300.4 6303.1 6303.4 6308.6 1136.1 1158.5 1181.8 1183.1 1191.2 763.0 771.4 772.6 782.9 793.3 12529.7 12660.7 13149.3 13239.7 13645.0 747.7 753.8 757.4 774.0 776.5 6214.3 6237.5 6276.1 6319.8 6382.1 159906.2 161654.2 162555.0 164436.0 170112.0 147579.0 148670.0 148725.0 150556.0 151030.0 126120.0 130615.3 131582.0 131831.0 132321.0 11441.7 11448.0 11537.8 12049.3 12209.9 61658.7 62644.7 63351.7 63641.4 65529.0 77422.6 78105.6 79598.2 80564.0 80608.0 17246.6 17891.7 18148.5 18206.5 18214.8 16971.5 17222.5 17240.6 17444.0 17502.7 15357.0 15650.6 15723.3 15745.3 15867.6 15661.1 15703.4 15875.4 15897.4 16035.6 15089.5 15120.5 15218.2 15262.4 15376.3 11726.2 11777.4 11906.2 11936.6 12333.9 11363.7 11558.4 11602.6 11642.2 11774.3 06:02:06 INFO - PID 29116 | -------- Summary: end -------- 06:02:06 INFO - PID 29116 | 06:02:06 INFO - TEST-INFO | 29116: exit 0 06:02:06 INFO - TEST-OK | dromaeo_css | took 1107056ms 06:02:06 INFO - TEST-START | kraken 06:02:06 INFO - Initialising browser for kraken test... 06:02:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60209/getInfo.html -profile /tmp/tmpqjcxVh/profile 06:02:06 INFO - TEST-INFO | started process 29510 (/builds/slave/test/build/application/firefox/firefox http://localhost:60209/getInfo.html) 06:02:11 INFO - TEST-INFO | 29510: exit 0 06:02:11 INFO - Browser initialized. 06:02:11 INFO - Running cycle 1/1 for kraken test... 06:02:11 INFO - Using env: {'DISPLAY': ':0', 06:02:11 INFO - 'HOME': '/home/cltbld', 06:02:11 INFO - 'JSGC_DISABLE_POISONING': '1', 06:02:11 INFO - 'LANG': 'en_US.UTF-8', 06:02:11 INFO - 'LANGUAGE': 'en_US:en', 06:02:11 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:02:11 INFO - 'LOGNAME': 'cltbld', 06:02:11 INFO - 'MAIL': '/var/mail/cltbld', 06:02:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:11 INFO - 'MOZ_CRASHREPORTER': '1', 06:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:11 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:02:11 INFO - 'MOZ_NO_REMOTE': '1', 06:02:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:11 INFO - 'NO_EM_RESTART': '1', 06:02:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:11 INFO - 'PWD': '/builds/slave/test', 06:02:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:11 INFO - 'RUST_BACKTRACE': 'full', 06:02:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:02:11 INFO - 'SHELL': '/bin/bash', 06:02:11 INFO - 'SHLVL': '1', 06:02:11 INFO - 'STYLO_FORCE_DISABLED': '1', 06:02:11 INFO - 'TERM': 'linux', 06:02:11 INFO - 'TMOUT': '86400', 06:02:11 INFO - 'USER': 'cltbld', 06:02:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704', 06:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:11 INFO - '_': '/tools/buildbot/bin/python'} 06:02:11 INFO - TEST-INFO | started process 29782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqjcxVh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:02:12 INFO - PID 29782 | 06:02:12 INFO - PID 29782 | (/builds/slave/test/build/application/firefox/firefox:29831): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:02:12 INFO - PID 29782 | 06:02:22 INFO - PID 29782 | RSS: Main: 147845120 06:02:22 INFO - PID 29782 | 06:02:25 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-beat-detection) 06:02:25 INFO - PID 29782 | RSS: Main: 153051136 06:02:25 INFO - PID 29782 | 06:02:28 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-dft) 06:02:29 INFO - PID 29782 | RSS: Main: 153415680 06:02:29 INFO - PID 29782 | 06:02:32 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-fft) 06:02:32 INFO - PID 29782 | RSS: Main: 149852160 06:02:32 INFO - PID 29782 | 06:02:34 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60209/tests/kraken/driver.html?testName=audio-oscillator) 06:02:35 INFO - PID 29782 | RSS: Main: 151343104 06:02:35 INFO - PID 29782 | 06:02:37 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60209/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:02:37 INFO - PID 29782 | RSS: Main: 150274048 06:02:37 INFO - PID 29782 | 06:02:41 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60209/tests/kraken/driver.html?testName=imaging-darkroom) 06:02:41 INFO - PID 29782 | RSS: Main: 150773760 06:02:41 INFO - PID 29782 | 06:02:45 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60209/tests/kraken/driver.html?testName=imaging-desaturate) 06:02:45 INFO - PID 29782 | RSS: Main: 151965696 06:02:45 INFO - PID 29782 | 06:02:48 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60209/tests/kraken/driver.html?testName=json-parse-financial) 06:02:49 INFO - PID 29782 | RSS: Main: 153522176 06:02:49 INFO - PID 29782 | 06:02:50 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60209/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:02:51 INFO - PID 29782 | RSS: Main: 153571328 06:02:51 INFO - PID 29782 | 06:02:52 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:02:53 INFO - PID 29782 | RSS: Main: 153423872 06:02:53 INFO - PID 29782 | 06:02:55 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:02:56 INFO - PID 29782 | RSS: Main: 150589440 06:02:56 INFO - PID 29782 | 06:02:58 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:02:59 INFO - PID 29782 | RSS: Main: 150466560 06:02:59 INFO - PID 29782 | 06:03:01 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:03:02 INFO - PID 29782 | RSS: Main: 151048192 06:03:02 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | Cycle 1(1): loaded http://localhost:60209/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60209/tests/kraken/driver.html?testName=ai-astar) 06:03:04 INFO - PID 29782 | RSS: Main: 152395776 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | __start_tp_report 06:03:04 INFO - PID 29782 | _x_x_mozilla_page_load 06:03:04 INFO - PID 29782 | _x_x_mozilla_page_load_details 06:03:04 INFO - PID 29782 | |i|pagename|runs| 06:03:04 INFO - PID 29782 | |0;ai-astar;106;104;105;107;106;105;106;106;105;105 06:03:04 INFO - PID 29782 | |1;audio-beat-detection;122;114;112;115;111;111;111;112;113;111 06:03:04 INFO - PID 29782 | |2;audio-dft;163;162;160;161;161;161;162;160;165;169 06:03:04 INFO - PID 29782 | |3;audio-fft;73;75;74;74;74;73;73;73;73;73 06:03:04 INFO - PID 29782 | |4;audio-oscillator;78;79;78;77;80;77;77;128;78;78 06:03:04 INFO - PID 29782 | |5;imaging-gaussian-blur;114;114;114;113;113;113;113;113;114;114 06:03:04 INFO - PID 29782 | |6;imaging-darkroom;150;150;152;150;150;152;150;150;150;151 06:03:04 INFO - PID 29782 | |7;imaging-desaturate;94;94;93;94;94;93;94;94;94;94 06:03:04 INFO - PID 29782 | |8;json-parse-financial;43;43;43;42;44;47;48;43;43;45 06:03:04 INFO - PID 29782 | |9;json-stringify-tinderbox;36;37;36;37;37;36;36;36;36;36 06:03:04 INFO - PID 29782 | |10;stanford-crypto-aes;70;70;72;70;71;71;70;73;72;71 06:03:04 INFO - PID 29782 | |11;stanford-crypto-ccm;107;104;104;113;105;107;104;106;102;103 06:03:04 INFO - PID 29782 | |12;stanford-crypto-pbkdf2;149;152;146;163;151;146;154;153;150;145 06:03:04 INFO - PID 29782 | |13;stanford-crypto-sha256-iterative;63;58;58;55;58;59;58;58;58;63 06:03:04 INFO - PID 29782 | __end_tp_report 06:03:04 INFO - PID 29782 | __start_cc_report 06:03:04 INFO - PID 29782 | _x_x_mozilla_cycle_collect,726 06:03:04 INFO - PID 29782 | __end_cc_report 06:03:04 INFO - PID 29782 | __startTimestamp1507122184451__endTimestamp 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | ------- Summary: start ------- 06:03:04 INFO - PID 29782 | Number of tests: 14 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#0] ai-astar Cycles:10 Average:105.50 Median:106.00 stddev:0.85 (0.8%) stddev-sans-first:0.88 06:03:04 INFO - PID 29782 | Values: 106.0 104.0 105.0 107.0 106.0 105.0 106.0 106.0 105.0 105.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#1] audio-beat-detection Cycles:10 Average:113.20 Median:112.50 stddev:3.39 (3.0%) stddev-sans-first:1.48 06:03:04 INFO - PID 29782 | Values: 122.0 114.0 112.0 115.0 111.0 111.0 111.0 112.0 113.0 111.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 06:03:04 INFO - PID 29782 | Values: 163.0 162.0 160.0 161.0 161.0 161.0 162.0 160.0 165.0 169.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#3] audio-fft Cycles:10 Average:73.50 Median:73.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 06:03:04 INFO - PID 29782 | Values: 73.0 75.0 74.0 74.0 74.0 73.0 73.0 73.0 73.0 73.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:78.00 stddev:15.84 (20.3%) stddev-sans-first:16.70 06:03:04 INFO - PID 29782 | Values: 78.0 79.0 78.0 77.0 80.0 77.0 77.0 128.0 78.0 78.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:03:04 INFO - PID 29782 | Values: 114.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 114.0 114.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 06:03:04 INFO - PID 29782 | Values: 150.0 150.0 152.0 150.0 150.0 152.0 150.0 150.0 150.0 151.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:03:04 INFO - PID 29782 | Values: 94.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#8] json-parse-financial Cycles:10 Average:44.10 Median:43.50 stddev:1.97 (4.5%) stddev-sans-first:2.05 06:03:04 INFO - PID 29782 | Values: 43.0 43.0 43.0 42.0 44.0 47.0 48.0 43.0 43.0 45.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#9] json-stringify-tinderbox Cycles:10 Average:36.30 Median:36.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 06:03:04 INFO - PID 29782 | Values: 36.0 37.0 36.0 37.0 37.0 36.0 36.0 36.0 36.0 36.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#10] stanford-crypto-aes Cycles:10 Average:71.00 Median:71.00 stddev:1.05 (1.5%) stddev-sans-first:1.05 06:03:04 INFO - PID 29782 | Values: 70.0 70.0 72.0 70.0 71.0 71.0 70.0 73.0 72.0 71.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#11] stanford-crypto-ccm Cycles:10 Average:105.50 Median:105.50 stddev:3.10 (2.9%) stddev-sans-first:3.24 06:03:04 INFO - PID 29782 | Values: 107.0 104.0 104.0 113.0 105.0 107.0 104.0 106.0 102.0 103.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:151.50 stddev:5.26 (3.5%) stddev-sans-first:5.53 06:03:04 INFO - PID 29782 | Values: 149.0 152.0 146.0 163.0 151.0 146.0 154.0 153.0 150.0 145.0 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.80 Median:58.00 stddev:2.44 (4.2%) stddev-sans-first:2.06 06:03:04 INFO - PID 29782 | Values: 63.0 58.0 58.0 55.0 58.0 59.0 58.0 58.0 58.0 63.0 06:03:04 INFO - PID 29782 | -------- Summary: end -------- 06:03:04 INFO - PID 29782 | 06:03:04 INFO - PID 29782 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:03:05 INFO - TEST-INFO | 29782: exit 0 06:03:05 INFO - TEST-OK | kraken | took 58620ms 06:03:05 INFO - SUITE-END | took 1165s 06:03:05 INFO - Completed test suite (00:19:26) 06:03:05 INFO - javascript benchmark 06:03:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9188.840989358408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3876.767393956363, 3882.223555288943, 3892.318844202264, 3909.6676782473487, 3920.647141757241, 6248.15649887265, 6256.749730010805, 6294.685265736712, 6310.7791227307, 6375.23497180339, 6316.27362853272, 6330.050492426139, 6331.968340158304, 6334.239891213049, 6355.777547785829, 5545.1682247662975, 5688.232088668018, 5690.516306113965, 5753.827385178452, 5761.884762304751, 5671.8014869479575, 5704.629199102066, 5746.310442746855, 5824.068149096145, 5853.473187413132, 5553.527950124244, 5645.971770141164, 5658.34928983164, 5738.598298119134, 5766.423357664242, 5667.3482549506925, 5668.121441176624, 5733.054046082391, 5734.139879018139, 5770.942290577124, 5582.665040097607, 5599.272094627672, 5630.352509461423, 5636.15457681347, 5718.456746609066, 6284.214473190851, 6297.811065668037, 6303.464205542535, 6319.33646967071, 6350.872982540323, 6905.654717264117, 6912.723491060352, 6923.273056329063, 6930.683170197697, 6937.063496427968, 6854.897176542356, 6865.9313406865795, 6878.0, 6948.895766563505, 6969.721211151548, 6279.026750853625, 6288.151099601587, 6292.150559674477, 6312.842178945517, 6316.905246421307, 6724.865502689919, 6963.059986901805, 6989.30106989297, 7034.788956331318, 7098.148222213367, 6780.660966951633, 6795.864082718318, 6845.657717114124, 6871.415929645936, 6879.965600172067, 6918.930810691829, 6936.861262774716, 6985.336393042653, 6996.160460744743, 7036.6481675916, 6729.798106056728, 6797.694103765342, 6827.726890924407, 6835.4189893859575, 6839.555428897106, 6766.966165169143, 6840.794776156723, 6845.041694162821, 6861.176658800976, 6861.93639985803, 4931.876703082452, 4973.179425394842, 4975.726335051607, 4994.700317980933, 5013.523715247045, 4467.530909254481, 4516.864494065183, 4536.727796332165, 4591.449026116888, 4596.448426188812, 6192.504599632109, 6195.938040619536, 6253.53098517613, 6264.655443950626, 6269.811905642838, 6721.227058888193, 6761.154855643044, 6800.455963522906, 6826.419754320938, 6829.863402731918, 6268.122462855204, 6270.717817698214, 6279.497640188774, 6279.843003924847, 6331.556791024676, 5458.863528411742, 5521.668699878021, 5533.557315414838, 5534.252875861787, 5535.8892822144135, 7126.251743566851, 7153.391961683211, 7166.892496612555, 7253.455990800711, 7266.600336981517, 6722.764703235363, 6752.729890804313, 6823.488238382042, 6824.692888819915, 6837.008633748178, 7145.321194486515, 7180.5691658500655, 7183.604901730455, 7213.278672132745, 7230.385417239593, 6753.3246675332075, 6791.830204244736, 6801.0, 6873.312668733087, 6879.484038697017, 6777.288384719731, 6842.521023528305, 6860.794176174722, 6949.096617439701, 6950.687219075053, 6614.867702645824, 6634.867302654016, 6637.966810165918, 6638.502112341497, 6639.435647969976, 6504.837379065372, 6603.669816509251, 6610.669466526559, 6615.768448104293, 6661.700223489857, 6559.7376104955265, 6573.309802470863, 6597.934020659732, 6613.107230523818, 6625.801225963229, 6637.966810165918, 6646.8005959821285, 6711.597304161766, 6730.158730158731, 6735.898961515483, 6331.620102793847, 6431.260405053479, 6435.0, 6531.510136739668, 6561.0], "value": 6252.34080303385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [951.3816019587267, 962.5524131278954, 983.2478154212027, 1017.7303014701101, 1020.2959957629231, 43255.78372108139, 45338.54661453389, 45696.0, 45817.0, 45850.312245316345, 43478.34782478266, 46113.53886461134, 46980.29529557059, 47011.29483057757, 47078.76460617692, 8696.73909782706, 8848.5575721214, 8855.15875991783, 8863.95568022159, 8864.246539044158, 8565.48607083577, 8807.295416366675, 8809.295256379473, 8822.0, 8825.823483530325, 8786.253168480687, 8825.161609647106, 8855.73432797017, 8859.512726800023, 8866.911330886705, 8722.084181160983, 8791.0, 8794.956025219897, 8809.559522023874, 8812.559372031405, 8599.44103633268, 8665.566721663892, 8699.260562852101, 8703.0, 8734.12658734128, 41769.373459398135, 41988.790056049525, 42067.158656826694, 42072.0, 42099.789501052604, 3812.618738126193, 3846.7499612525376, 3846.769193848378, 3846.9807650961848, 3849.0377405648587, 32297.838510807294, 32619.51070733941, 33076.503852442234, 33192.50211246833, 33216.1695957603, 5509.944900550983, 5607.52336051432, 5628.493435590816, 5675.772969081232, 5677.034904066319, 226728.8663556688, 227132.0, 227276.0, 227783.0, 227866.0, 53137.468625314024, 53794.0, 53950.73024634852, 54019.408350290665, 54030.729846350514, 56756.71621641865, 57371.42628573744, 57386.0, 57409.425905740405, 57459.0, 17499.475015749293, 17634.647307053787, 17635.294588216584, 17651.293948242183, 17656.293748250184, 14330.21183834899, 14368.281585920662, 14369.425222991173, 14384.928075359765, 14387.568372948828, 13691.452341906212, 13854.099483533539, 13940.86059139416, 13976.580702578938, 14110.365033573515, 5334.426344228462, 5349.893002139936, 5395.73021348931, 5461.1262198048125, 5488.615796894259, 1056.4453661827602, 1084.5878566144972, 1093.8085834978847, 1104.276698762312, 1106.4136007915818, 25531.36171595688, 25825.354366140997, 25891.611625825626, 26049.609255861178, 26223.737762622128, 1183.8398369597842, 1187.5215356880567, 1210.8849659282355, 1216.7688139253514, 1221.6396163131897, 13330.200187988752, 13595.52415665447, 13642.976776741783, 13713.931430342784, 13787.310634468437, 287015.0, 288012.0, 288462.0, 289182.0, 289685.0, 53285.7335713319, 55107.0, 60332.0, 61432.69283653642, 61762.38237617656, 1559.5555266748922, 1562.1798555758319, 1568.4902406717863, 1571.2379495944458, 1575.243882936197, 31173.0, 31365.215869603442, 32011.839940800146, 32285.838570806995, 32388.514172286963, 43174.78412607917, 43239.35140972825, 43282.35076473918, 43347.783261083496, 43372.783136084116, 251119.0, 252135.0, 252642.0, 252793.0, 254148.0, 37245.81377093206, 38221.4266786004, 38403.615963840006, 38675.0, 38682.806585968014, 47327.870245838334, 48376.758116209196, 48687.513124869714, 48813.0, 48910.0, 35660.10849728777, 35884.64115358813, 36143.81928090343, 36193.63806361903, 36307.63692363042, 35489.467657984635, 35724.10689732777, 35729.46405803967, 36155.81922090373, 36480.0, 41984.58015419929, 42673.0, 42806.78596607121, 43384.13231735284, 43388.783056085784, 34570.13574660654, 34673.30653386968, 35087.82456087703, 35177.29645407027, 35986.64013359938, 25865.353366165997, 25888.093916712824, 26198.214053578424, 26543.86728066347, 26683.33291667724], "value": 19245.226431841915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.2021832273016, 630.9558330916838, 639.9520035997299, 643.4305639509033, 653.705832375431, 22872.65691014636, 23415.1804686836, 23521.529569408645, 24264.029438822447, 24338.39154021148, 23095.884520577416, 23565.882170589124, 23569.5286094278, 23572.88213558934, 23598.5280294394, 6618.8676226475445, 6738.225104113017, 6891.7932462025965, 6898.793036208922, 6905.413039891615, 6801.93198068018, 6805.727770889159, 6834.624095674761, 6844.31556844314, 6844.589324640513, 6744.561603495782, 6756.851335273015, 6774.5257831951785, 6795.93204067958, 6803.217629972567, 6731.831704207385, 6772.356626120511, 6775.288594697559, 6777.390034896883, 6778.627175505345, 6322.968385158045, 6339.175907132089, 6349.142865713162, 6361.650109243989, 6361.968190159066, 29036.27409314763, 31421.528677069862, 31486.055418337488, 31622.683773162204, 31710.841445792623, 2256.2216035467736, 2309.434188623781, 2313.34069790109, 2316.224064938248, 2317.154238702878, 19978.400647980583, 20254.69617955732, 20549.794502054938, 20661.4834629134, 20758.896205519028, 2516.7357427470033, 2574.8197626166175, 2607.296030071889, 2612.0988259050596, 2617.7251388604113, 146093.0, 154021.22989385095, 157045.0, 164073.0, 164610.9999999988, 15222.238888055554, 16125.758113628304, 16178.75731864023, 16683.83316166847, 17174.141292935303, 26663.33341666474, 26689.398636081896, 26783.660816959073, 26805.061822836105, 26845.463090738074, 11008.174386921013, 11010.064144547643, 11095.722606934729, 11245.212835101627, 11256.831147532794, 10006.949965250127, 10066.043725846033, 10264.64073757415, 10284.331518451278, 10327.380357178594, 9758.316917815684, 10103.545340459697, 10157.409860485528, 10213.846792298122, 10219.0, 2872.5116730155924, 2883.163882474059, 2942.367391010943, 2952.247176969902, 3008.353204061137, 1025.17985611512, 1055.3984228989557, 1064.2975636080305, 1069.9144068474504, 1079.8110330692098, 20538.0, 20720.378388648365, 20731.792682073286, 21041.579168416545, 21362.14551417957, 1105.8451816745662, 1118.8769235384102, 1120.6245907620876, 1124.291696231369, 1131.6944425005202, 11426.542938282375, 11459.255148415326, 11475.254108482923, 11537.250078745023, 11615.709607259887, 628912.0, 632505.0, 648077.0, 650362.0, 676696.0, 125060.0, 129361.0, 129846.0, 132220.0, 136837.0, 1118.3904771899333, 1163.947622356996, 1228.1648479034343, 1231.2612432540584, 1295.164618820874, 22530.0, 22574.20990265333, 22755.0, 22780.316590502312, 22850.200242991414, 62524.0, 63330.36669633429, 63548.0, 65350.34649653633, 65683.67158164179, 81478.0, 82453.17546824455, 82630.0, 82776.0, 83183.0, 15568.455104071303, 16074.43739469113, 16142.354305828105, 16150.111743853731, 16167.0, 24250.272491825275, 24343.634845477685, 24387.75612243855, 24479.26562203137, 24584.0, 19930.60138797187, 19950.90024549926, 20017.0, 20089.598208036048, 20298.492537686085, 17567.297308107532, 17717.20272587711, 17749.201285941905, 18136.909315453337, 18161.636767264845, 20103.89948050309, 20251.0, 20261.189552418327, 20437.69343459879, 20466.795332047084, 15634.843651563793, 15816.841831581536, 15841.366345346518, 15947.44183953556, 15981.920090399939, 18586.44240672782, 18725.15736791875, 18904.338348157748, 18923.337683181024, 18968.336108236144], "value": 12993.328280447427, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.3614009835674, 1518.954431367058, 1530.762731776575, 1536.7694845773133, 1540.6764579438318, 16531.256093475793, 17325.0, 17345.04602246876, 17350.652986940255, 17377.30490780367, 16899.324027038936, 17002.0, 17018.149092545355, 17096.230669619865, 17140.914295428505, 2895.0, 2953.394554116406, 2963.096255642028, 2965.9258518537104, 2972.895948641798, 2922.7515661168827, 2950.498415269409, 2952.8483891282417, 2953.911382658513, 2961.452131355706, 2899.4201159768027, 2970.1683528612025, 2972.093511478998, 2983.254186453387, 2997.0, 2449.7060352757603, 2477.2196758021255, 2510.4853505031424, 2511.3470497670555, 2512.6733524641772, 2705.6076868853906, 2747.7939154563487, 2982.2693440107096, 2989.237744375192, 2990.7158819912074, 16670.58323541909, 16796.0, 16802.243899024572, 16821.495355139366, 16854.073025983565, 8584.527850968194, 8801.867971980426, 8822.735317940407, 8832.8675069874, 8844.11558844117, 5748.45389687979, 5913.113033045035, 5967.9701601491715, 6009.789657362015, 6030.758769649209, 2196.428928478591, 2203.0747086223823, 2212.15937943582, 2216.822654187661, 2264.864108153516, 30057.549136762966, 30180.396392072034, 30370.240743981358, 30437.23906902323, 31011.84494077515, 7656.234376562411, 7744.49660772048, 7813.960930195312, 7828.0, 7929.167437418988, 19418.0, 19437.902810485855, 19474.22103115888, 19534.902325488565, 19559.413217603495, 8836.381453298207, 8976.147266009719, 9065.048169942193, 9066.138716821892, 9067.274618030673, 8046.919530804734, 8085.0, 8116.918830811735, 8215.0, 8221.712240071569, 6045.758169673251, 6059.121427393004, 6061.969690151521, 6080.543959203077, 6168.537359698041, 1754.2369069454828, 1758.709812880886, 1806.9186886590135, 1807.9276828926959, 1808.032702504154, 910.299069716328, 915.8900931888217, 927.3879239701764, 940.7130825098411, 951.923846092311, 8072.515649061075, 8113.310368618733, 8121.75634730959, 8144.674213031531, 8191.344692424592, 759.8822182561712, 790.5612385126195, 798.7523867601062, 811.8701007838836, 822.8930239068883, 5058.873528161752, 5242.9737851311265, 6064.514838812885, 6102.016844525547, 6301.6534090625455, 24156.275311740676, 24325.270241892773, 25527.48945021089, 25695.48609027809, 25806.741932580808, 24054.7594524056, 24356.391090222885, 24698.629520557206, 24891.0, 24909.750902490745, 11237.21339506243, 11237.269577477438, 12064.336461494526, 12114.15200935926, 12338.938305308417, 10288.331258468175, 10308.12380947628, 10324.43215623148, 10392.272540922062, 10673.0, 20557.280495182596, 20616.48458788542, 20777.58444831065, 20879.791202088392, 21142.0, 21547.353579392642, 21557.0, 21560.67658985148, 21879.234226801986, 22038.228661996753, 12471.064670149957, 12598.0, 12643.114981951176, 12700.936495317465, 12862.614121576367, 15228.390864365301, 15449.922750386626, 15450.613734656723, 15455.922720386327, 15458.072515649097, 12636.87363126357, 12639.747205056032, 12830.358482076046, 12836.294003829878, 13138.0, 11901.285922844658, 12056.156069075432, 12298.385080745747, 12406.193597416139, 12462.189957652723, 11087.390193539433, 11092.057175140204, 11100.5559777608, 11156.944215278872, 11160.330380177214, 7968.402369822403, 7979.321757650432, 7998.760037198894, 8075.838483230185, 8093.514389136435, 7726.652300646372, 7743.7676869694, 7787.338076263581, 7800.531968081933, 7896.84206315882], "value": 7342.331383407399, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9668219906804, 564.6386312759834, 579.149616973769, 583.361219464686, 585.794971759884, 6296.811095667126, 6300.527460440474, 6321.6523091229965, 6368.0, 6436.452901503366, 6179.9691001544925, 6280.874382512347, 6281.968590157055, 6297.874042519147, 6323.577195131104, 5115.462876397981, 5143.3570803649545, 5159.277701121846, 5179.611529135311, 5205.0, 5022.949770502303, 5074.492550744914, 5109.591232701375, 5137.049645815536, 5148.974255128719, 5035.823746168885, 5069.949300506984, 5082.542571168594, 5102.668326558781, 5118.692878427288, 5091.949080509203, 5103.2855400244, 5117.8464646060675, 5129.12804823181, 5148.716820574867, 4641.559051890065, 4675.836345727883, 4681.789319480631, 4722.693024953367, 4727.125481785846, 6144.78493252734, 6213.56505044647, 6275.8744825103695, 6292.276388215368, 6312.043266587372, 5936.109583562457, 5956.344802071769, 5965.28416590012, 5972.223610930551, 5975.25309336333, 6665.266820649773, 6682.83292917676, 6750.561213521106, 6760.6619669016845, 6767.560108592926, 4985.401751789772, 5132.563732082777, 5197.454267301954, 5233.325335892516, 5245.160774276097, 6772.966135169293, 6880.58716477013, 6966.9651651741415, 6972.616506092163, 7033.331833475811, 5311.946880531223, 5347.919781203285, 5351.759170837322, 5352.518273355417, 5383.977044361559, 5394.3796463406425, 5426.864328391822, 5438.864028399322, 5451.209574611738, 5481.342238931354, 5952.553558483131, 5987.790427335022, 6000.099985002197, 6013.639181649115, 6027.156198132265, 6714.194296684332, 6758.837172104978, 6773.729050837911, 6802.863942721118, 6849.630073985223, 1821.9614819552992, 1848.704207326848, 1855.7844611779306, 1880.3982725527974, 1899.7340372347883, 1276.9872301276869, 1350.210127075652, 1351.1082685427766, 1355.3629793996806, 1369.4111532041318, 6078.0579010252595, 6146.6004709693725, 6164.4760195383, 6178.969105154535, 6281.59169653971, 6481.28705842357, 6568.146141001735, 6676.666166691646, 6694.397504224643, 6731.124953756078, 6112.449879510866, 6136.938630613726, 6140.17107690465, 6160.784372546939, 6162.506999440034, 3504.5444092267844, 3540.1857572757895, 3540.6105328413855, 3587.408077667208, 3599.190182208982, 7025.859482810315, 7040.577565346096, 7082.327178917994, 7119.501634885612, 7120.4690991436055, 6988.44092472601, 7022.719091236396, 7024.894626580605, 7050.823729406703, 7083.539569927938, 7003.26465721092, 7003.649817509104, 7009.264027277062, 7193.172785129673, 7204.0, 6775.898361524482, 6802.591844489149, 6821.795346139624, 6832.385085342343, 6866.382025617719, 6676.230798838409, 6755.42578880781, 6773.288804675438, 6784.321567843176, 6831.453483721191, 6889.311068893071, 7039.9296007039275, 7184.1738200105565, 7213.350798428167, 7229.710811567689, 5332.20016997438, 5387.542058924879, 5390.897549955599, 5393.352797664305, 5407.405185429679, 6535.607863528204, 6708.396244338033, 6817.693203805741, 6865.656717164222, 6892.138482689664, 6312.581193164711, 6476.70854811544, 6572.967135164294, 6593.175853018372, 6643.40209381158, 6469.385408386196, 6501.544891857525, 6505.73977040932, 6544.28012918569, 6625.238097618835, 6342.651154186379, 6388.872222555616, 6454.805860915746, 6466.4503517201565, 6494.415502604788, 6624.701888414937, 6657.667116644246, 6658.866822663423, 6726.327367263235, 6742.460603151638, 6436.227652681709, 6472.611643301417, 6488.12410324619, 6567.835804104936, 6572.737090516326], "value": 5254.135215686287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [958.9520523973799, 985.7278971969611, 985.9014098590142, 990.4750482244413, 1015.6089905386426, 20902.268420605284, 21980.120795168175, 22013.66979495305, 22017.779822201774, 22024.669629955544, 19577.314793982212, 20074.698879516818, 20540.38378848633, 20711.896440517816, 20718.792812071875, 1067.8558394616725, 1102.2339474065527, 1103.5806393570433, 1103.7957977774097, 1109.8612673415823, 1047.261680515235, 1081.9621313254038, 1088.6733979806027, 1104.2932523185168, 1105.9889401105966, 1157.8668453127914, 1161.7037655397862, 1162.0819552553473, 1170.180873388627, 1171.1801738782885, 1090.4711215060688, 1166.7433164703752, 1166.8249762535602, 1167.1713083710576, 1169.7017260598577, 812.2608426332068, 818.4925346285341, 818.7175424478545, 820.8071103290722, 820.9220124088203, 21439.249626263005, 21527.569448611095, 21565.892170539046, 21570.245041423474, 21611.459713507287, 22879.0, 23705.407364815845, 23870.76129238703, 23889.0, 23918.402039948967, 18484.72272915907, 19076.904615476833, 19157.521061973424, 19206.711899321523, 19251.90374048135, 4001.9399709004388, 4023.7988100595144, 4032.6370626643447, 4037.1118353962083, 4037.4751282333405, 169913.15043424827, 170177.0, 170759.0, 170961.0, 171799.28200718082, 17564.5608859777, 17783.110844457726, 17956.730649040273, 17971.820281797278, 18130.818691813176, 34793.0, 35387.64612353895, 35620.28759424849, 35975.28049439049, 36003.4599481008, 7950.681972721027, 8082.9191708083345, 8119.715809946623, 8140.023197216372, 8151.470154439942, 4212.957870421256, 4314.460692413449, 4354.804033818423, 4381.058072514425, 4411.691181617321, 6177.382261773877, 6300.401461861115, 6303.149074874925, 6303.401176888188, 6308.589941653778, 1136.1195073817858, 1158.478684591937, 1181.8050021746487, 1183.0535571542732, 1191.1721353659125, 762.9580373079534, 771.3636250093583, 772.563501621582, 782.9217078292126, 793.2979313307765, 12529.721700205959, 12660.683482913, 13149.276789776653, 13239.669008274677, 13645.0, 747.7457664394132, 753.7701001194579, 757.443279189795, 774.0285941143828, 776.5379599138504, 6214.291069955799, 6237.500999919996, 6276.089966954766, 6319.778807741707, 6382.106505089291, 159906.20046899925, 161654.1917290406, 162555.0, 164436.0, 170112.0, 147579.0, 148670.0, 148725.0, 150556.0, 151030.0, 126120.0, 130615.34692326668, 131582.0, 131831.0, 132320.99999999808, 11441.656750297505, 11448.026917711755, 11537.769244615229, 12049.33728644898, 12209.938950305192, 61658.69170654118, 62644.686776565824, 63351.683241583494, 63641.36358636354, 65529.017064743115, 77422.61288693521, 78105.60947195228, 79598.20401795908, 80564.0, 80608.0, 17246.568835779206, 17891.73162402591, 18148.546286342946, 18206.45380638583, 18214.81785182184, 16971.490855274362, 17222.536084432963, 17240.568985775455, 17444.0, 17502.73745893838, 15357.0, 15650.608734781721, 15723.304859180187, 15745.291461884013, 15867.603309917344, 15661.138637375054, 15703.371865125268, 15875.364985400454, 15897.364105436116, 16035.599110022344, 15089.54731358061, 15120.470783522524, 15218.16300103505, 15262.3895044197, 15376.308066136828, 11726.179167458537, 11777.35224562623, 11906.166568340133, 11936.641900742992, 12333.93833030865, 11363.715907102058, 11558.364289964133, 11602.593909213138, 11642.233273642254, 11774.293542387484], "value": 9979.6640165373, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 107.0, 106.0, 105.0, 106.0, 106.0, 105.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 114.0, 112.0, 115.0, 111.0, 111.0, 111.0, 112.0, 113.0, 111.0], "value": 113.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 160.0, 161.0, 161.0, 161.0, 162.0, 160.0, 165.0, 169.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 74.0, 74.0, 73.0, 73.0, 73.0, 73.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 77.0, 80.0, 77.0, 77.0, 128.0, 78.0, 78.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 152.0, 150.0, 150.0, 152.0, 150.0, 150.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 43.0, 42.0, 44.0, 47.0, 48.0, 43.0, 43.0, 45.0], "value": 44.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 36.0, 37.0, 37.0, 36.0, 36.0, 36.0, 36.0, 36.0], "value": 36.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 72.0, 70.0, 71.0, 71.0, 70.0, 73.0, 72.0, 71.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 104.0, 113.0, 105.0, 107.0, 104.0, 106.0, 102.0, 103.0], "value": 105.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 146.0, 163.0, 151.0, 146.0, 154.0, 153.0, 150.0, 145.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 58.0, 58.0, 55.0, 58.0, 59.0, 58.0, 58.0, 58.0, 63.0], "value": 58.8, "unit": "score"}]}]} 06:03:05 INFO - Return code: 0 06:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:03:05 INFO - # TBPL SUCCESS # 06:03:05 INFO - Running post-action listener: _package_coverage_data 06:03:05 INFO - Running post-action listener: _resource_record_post_action 06:03:05 INFO - [mozharness: 2017-10-04 13:03:05.753152Z] Finished run-tests step (success) 06:03:05 INFO - Running post-run listener: _resource_record_post_run 06:03:05 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319500288; Read time: 4; Write time: 222824 06:03:05 INFO - TinderboxPrint: CPU usage
13.1% 06:03:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:03:05 INFO - TinderboxPrint: I/O write bytes / time
319,500,288 / 222,824 06:03:05 INFO - TinderboxPrint: CPU idle
8,204.8 (86.9%) 06:03:05 INFO - TinderboxPrint: CPU user
1,186.5 (12.6%) 06:03:05 INFO - TinderboxPrint: Swap in / out
0 / 0 06:03:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12746752; Read time: 0; Write time: 1288 06:03:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:03:05 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 305123328; Read time: 0; Write time: 221460 06:03:06 INFO - Running post-run listener: _upload_blobber_files 06:03:06 INFO - Blob upload gear active. 06:03:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:03:06 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 06:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:03:06 INFO - (blobuploader) - INFO - Open directory for files ... 06:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 06:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 06:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:07 INFO - (blobuploader) - INFO - Done attempting. 06:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 06:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 06:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:08 INFO - (blobuploader) - INFO - Done attempting. 06:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:03:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:10 INFO - (blobuploader) - INFO - Done attempting. 06:03:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:03:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:03:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:03:13 INFO - (blobuploader) - INFO - Done attempting. 06:03:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:03:13 INFO - Return code: 0 06:03:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:03:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:03:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4220813ae69edd43d205effff8585ba80254463570899ac2917bb3542279eb711840f469bb31937214bdea7ceeed55ae849088242669b9eca6f294f0c64575d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b40cf3cdc67a9a1ee4b0e1ca92540d209143cf7a75dfcf22fd421476f88e61bfc3fae16500ba226d7edc91788e0e5a7359ecb09e03bf37cf5f071449a8736472", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd40180e3d766b4e307018fc2e193eb80d2d9dcf5315ef248f0606027b8b9b07c4802e329e6fc1e20acbad9efe8d2e1a4a6d929ba9c76620c70bc16f1109b619", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faaa77b04afe8dced7783f798b6c50631281436f61e6e38187d4fdb66b3da05e632794a81f96008a5111942c4e76804344dd9e5bddb3c2ac8b5e87792e38e016"} 06:03:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:03:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:03:13 INFO - Contents: 06:03:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4220813ae69edd43d205effff8585ba80254463570899ac2917bb3542279eb711840f469bb31937214bdea7ceeed55ae849088242669b9eca6f294f0c64575d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b40cf3cdc67a9a1ee4b0e1ca92540d209143cf7a75dfcf22fd421476f88e61bfc3fae16500ba226d7edc91788e0e5a7359ecb09e03bf37cf5f071449a8736472", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd40180e3d766b4e307018fc2e193eb80d2d9dcf5315ef248f0606027b8b9b07c4802e329e6fc1e20acbad9efe8d2e1a4a6d929ba9c76620c70bc16f1109b619", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faaa77b04afe8dced7783f798b6c50631281436f61e6e38187d4fdb66b3da05e632794a81f96008a5111942c4e76804344dd9e5bddb3c2ac8b5e87792e38e016"} 06:03:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:03:13 INFO - Copying logs to upload dir... 06:03:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:03:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.103370 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-04 06:03:13.462159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 06:03:13.465657) ========= 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=652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4220813ae69edd43d205effff8585ba80254463570899ac2917bb3542279eb711840f469bb31937214bdea7ceeed55ae849088242669b9eca6f294f0c64575d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b40cf3cdc67a9a1ee4b0e1ca92540d209143cf7a75dfcf22fd421476f88e61bfc3fae16500ba226d7edc91788e0e5a7359ecb09e03bf37cf5f071449a8736472", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd40180e3d766b4e307018fc2e193eb80d2d9dcf5315ef248f0606027b8b9b07c4802e329e6fc1e20acbad9efe8d2e1a4a6d929ba9c76620c70bc16f1109b619", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faaa77b04afe8dced7783f798b6c50631281436f61e6e38187d4fdb66b3da05e632794a81f96008a5111942c4e76804344dd9e5bddb3c2ac8b5e87792e38e016"} build_url:https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/E6uNJ6CDSdC-LmwGg1i0Wg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4220813ae69edd43d205effff8585ba80254463570899ac2917bb3542279eb711840f469bb31937214bdea7ceeed55ae849088242669b9eca6f294f0c64575d", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b40cf3cdc67a9a1ee4b0e1ca92540d209143cf7a75dfcf22fd421476f88e61bfc3fae16500ba226d7edc91788e0e5a7359ecb09e03bf37cf5f071449a8736472", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd40180e3d766b4e307018fc2e193eb80d2d9dcf5315ef248f0606027b8b9b07c4802e329e6fc1e20acbad9efe8d2e1a4a6d929ba9c76620c70bc16f1109b619", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faaa77b04afe8dced7783f798b6c50631281436f61e6e38187d4fdb66b3da05e632794a81f96008a5111942c4e76804344dd9e5bddb3c2ac8b5e87792e38e016"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 06:03:13.503140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 06:03:13.503631) ========= 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=652eb03db935cfc1c15ebda0000001ad-1507120958.870139-243502704 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 06:03:13.585876) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 06:03:13.586503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 06:03:13.587044) ========= ========= Total master_lag: 0.27 =========