builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1503706501.39 results: success (0) revision: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.386510) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.386967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.387240) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.403232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.403590) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 17:15:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-08-25 17:15:02 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.499191) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.499511) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016433 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:01.557758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 17:15:01.560116) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a --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 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a --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=fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 17:15:02,475 truncating revision to first 12 chars 2017-08-25 17:15:02,475 Setting DEBUG logging. 2017-08-25 17:15:02,475 attempt 1/10 2017-08-25 17:15:02,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/86a3c73984a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 17:15:04,022 unpacking tar archive at: mozilla-central-86a3c73984a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.854620 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 17:15:03.429575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:03.429964) ========= script_repo_revision: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:03.430393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:03.430655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 17:15:03.443805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-25 17:15:03.444295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:04 INFO - MultiFileLogger online at 20170825 17:15:04 in /builds/slave/test 17:15:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:15:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:15:04 INFO - {'append_to_log': False, 17:15:04 INFO - 'base_work_dir': '/builds/slave/test', 17:15:04 INFO - 'blob_upload_branch': 'Firefox', 17:15:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:15:04 INFO - 'branch': 'Firefox', 17:15:04 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:04 INFO - 'code_coverage': False, 17:15:04 INFO - 'config_files': ('talos/linux_config.py',), 17:15:04 INFO - 'default_actions': ('clobber', 17:15:04 INFO - 'read-buildbot-config', 17:15:04 INFO - 'download-and-extract', 17:15:04 INFO - 'populate-webroot', 17:15:04 INFO - 'create-virtualenv', 17:15:04 INFO - 'install', 17:15:04 INFO - 'setup-mitmproxy', 17:15:04 INFO - 'run-tests'), 17:15:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:04 INFO - 'disable_ccov_upload': False, 17:15:04 INFO - 'download_minidump_stackwalk': True, 17:15:04 INFO - 'download_symbols': 'ondemand', 17:15:04 INFO - 'enable_stylo': False, 17:15:04 INFO - 'enable_webrender': False, 17:15:04 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:15:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:04 INFO - 'gecko_profile': False, 17:15:04 INFO - 'gecko_profile_interval': 0, 17:15:04 INFO - 'installer_path': 'installer.exe', 17:15:04 INFO - 'log_level': 'info', 17:15:04 INFO - 'log_name': 'talos', 17:15:04 INFO - 'log_to_console': True, 17:15:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:04 INFO - 'opt_config_files': (), 17:15:04 INFO - 'pip_index': False, 17:15:04 INFO - 'suite': 'dromaeojs-e10s', 17:15:04 INFO - 'system_bits': '32', 17:15:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:04 INFO - 'title': 'talos-linux64-ix-075', 17:15:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:04 INFO - 'use_talos_json': True, 17:15:04 INFO - 'verify': 'False', 17:15:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:15:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:04 INFO - 'work_dir': 'build'} 17:15:04 INFO - [mozharness: 2017-08-26 00:15:04.494648Z] Running clobber step. 17:15:04 INFO - Running pre-action listener: _resource_record_pre_action 17:15:04 INFO - Running main action method: clobber 17:15:04 INFO - rmtree: /builds/slave/test/build 17:15:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:15:05 INFO - Running post-action listener: _resource_record_post_action 17:15:05 INFO - [mozharness: 2017-08-26 00:15:05.528447Z] Finished clobber step (success) 17:15:05 INFO - [mozharness: 2017-08-26 00:15:05.528545Z] Running read-buildbot-config step. 17:15:05 INFO - Running pre-action listener: _resource_record_pre_action 17:15:05 INFO - Running main action method: read_buildbot_config 17:15:05 INFO - Using buildbot properties: 17:15:05 INFO - { 17:15:05 INFO - "project": "", 17:15:05 INFO - "product": "firefox", 17:15:05 INFO - "who": "kwierso@gmail.com", 17:15:05 INFO - "installer_path": "public/build/target.tar.bz2", 17:15:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:15:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:15:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:15:05 INFO - "stage_platform": "linux64-stylo", 17:15:05 INFO - "basedir": "/builds/slave/test", 17:15:05 INFO - "buildnumber": 106, 17:15:05 INFO - "platform": "ubuntu64_hw_stylo", 17:15:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:15:05 INFO - "slavebuilddir": "test", 17:15:05 INFO - "taskId": "Aoxod4D0SGOwq5ob-C3JIw", 17:15:05 INFO - "branch": "mozilla-central", 17:15:05 INFO - "script_repo_revision": "production", 17:15:05 INFO - "revision": "86a3c73984a23b1d524eadbd4a62b9b3fa27e46a", 17:15:05 INFO - "slavename": "talos-linux64-ix-075", 17:15:05 INFO - "repo_path": "mozilla-central" 17:15:05 INFO - } 17:15:05 INFO - Finding installer, test and symbols from parent task. 17:15:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aoxod4D0SGOwq5ob-C3JIw'}, attempt #1 17:15:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aoxod4D0SGOwq5ob-C3JIw'}, attempt #1 17:15:06 INFO - Task dependencies: CvxZbX7nQM278U8qCtb6OQ 17:15:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ'}, attempt #1 17:15:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2 17:15:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.test_packages.json 17:15:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.crashreporter-symbols.zip 17:15:06 INFO - Running post-action listener: _resource_record_post_action 17:15:06 INFO - [mozharness: 2017-08-26 00:15:06.904331Z] Finished read-buildbot-config step (success) 17:15:06 INFO - [mozharness: 2017-08-26 00:15:06.904549Z] Running download-and-extract step. 17:15:06 INFO - Running pre-action listener: _resource_record_pre_action 17:15:06 INFO - Running main action method: download_and_extract 17:15:06 INFO - mkdir: /builds/slave/test/build/tests 17:15: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')]} 17:15:06 INFO - trying https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.test_packages.json 17:15:06 INFO - Downloading https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:15:07 INFO - Downloaded 989 bytes. 17:15:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:15:07 INFO - Using the following test package requirements: 17:15:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:15:07 INFO - u'common': [u'target.common.tests.zip'], 17:15:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:15:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:15:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:15:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:15:07 INFO - u'mozbase': [u'target.common.tests.zip'], 17:15:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:15:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:15:07 INFO - u'web-platform': [u'target.common.tests.zip', 17:15:07 INFO - u'target.web-platform.tests.tar.gz'], 17:15:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:15:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:15:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.common.tests.zip 17:15:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:15:07 INFO - Fetch https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.common.tests.zip into memory 17:15:08 INFO - Content-Length response header: 54979125 17:15:08 INFO - Bytes received: 54979125 17:15:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:15:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.common.tests.zip 17:15:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:15:19 INFO - Fetch https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.common.tests.zip into memory 17:15:20 INFO - Content-Length response header: 54979125 17:15:20 INFO - Bytes received: 54979125 17:15:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.talos.tests.zip 17:15:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:15:32 INFO - Fetch https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.talos.tests.zip into memory 17:15:33 INFO - Content-Length response header: 14496611 17:15:33 INFO - Bytes received: 14496611 17:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:33 INFO - trying https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2 17:15:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:15:35 INFO - Downloaded 61118480 bytes. 17:15:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2 17:15:35 INFO - mkdir: /builds/slave/test/properties 17:15:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:35 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:35 INFO - Contents: 17:15:35 INFO - build_url:https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2 17:15:35 INFO - Running post-action listener: _resource_record_post_action 17:15:35 INFO - Running post-action listener: find_tests_for_verification 17:15:35 INFO - Running post-action listener: set_extra_try_arguments 17:15:35 INFO - [mozharness: 2017-08-26 00:15:35.034435Z] Finished download-and-extract step (success) 17:15:35 INFO - [mozharness: 2017-08-26 00:15:35.034532Z] Running populate-webroot step. 17:15:35 INFO - Running pre-action listener: _resource_record_pre_action 17:15:35 INFO - Running main action method: populate_webroot 17:15:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:35 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:35 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:35 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'tests': ['damp', 'tps']}, 17:15:35 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['damp', 'tps']}, 17:15:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:15:35 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:15:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:15:35 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:15:35 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:35 INFO - 'ts_paint', 17:15:35 INFO - 'tpaint', 17:15:35 INFO - 'sessionrestore', 17:15:35 INFO - 'sessionrestore_many_windows', 17:15:35 INFO - 'sessionrestore_no_auto_restore', 17:15:35 INFO - 'tabpaint']}, 17:15:35 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['a11yr', 17:15:35 INFO - 'ts_paint', 17:15:35 INFO - 'tpaint', 17:15:35 INFO - 'sessionrestore', 17:15:35 INFO - 'sessionrestore_many_windows', 17:15:35 INFO - 'sessionrestore_no_auto_restore', 17:15:35 INFO - 'tabpaint']}, 17:15:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:15:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:15:35 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['bloom_basic_singleton']}, 17:15:35 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['bloom_basic']}, 17:15:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:35 INFO - 'tsvgr_opacity', 17:15:35 INFO - 'tart', 17:15:35 INFO - 'tscrollx', 17:15:35 INFO - 'tsvg_static']}, 17:15:35 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['tsvgx', 17:15:35 INFO - 'tsvgr_opacity', 17:15:35 INFO - 'tart', 17:15:35 INFO - 'tscrollx', 17:15:35 INFO - 'tsvg_static']}, 17:15:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:15:35 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'talos_options': ['--stylo'], 17:15:35 INFO - 'tests': ['tp5o']}, 17:15:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:15:35 INFO - 'talos_options': ['--mitmproxy', 17:15:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:15:35 INFO - '--firstNonBlankPaint'], 17:15:35 INFO - 'tests': ['tp6_google', 17:15:35 INFO - 'tp6_youtube', 17:15:35 INFO - 'tp6_amazon', 17:15:35 INFO - 'tp6_facebook']}, 17:15:35 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:15:35 INFO - 'talos_options': ['--stylo', 17:15:35 INFO - '--mitmproxy', 17:15:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:15:35 INFO - '--firstNonBlankPaint'], 17:15:35 INFO - 'tests': ['tp6_google', 17:15:35 INFO - 'tp6_youtube', 17:15:35 INFO - 'tp6_amazon', 17:15:35 INFO - 'tp6_facebook']}, 17:15:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:15:35 INFO - 'talos_options': ['--stylo', 17:15:35 INFO - '--stylo-threads=1', 17:15:35 INFO - '--mitmproxy', 17:15:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:15:35 INFO - '--firstNonBlankPaint'], 17:15:35 INFO - 'tests': ['tp6_google', 17:15:35 INFO - 'tp6_youtube', 17:15:35 INFO - 'tp6_amazon', 17:15:35 INFO - 'tp6_facebook']}, 17:15:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'talos_options': ['--xperf_path', 17:15:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:35 INFO - 'tests': ['tp5n']}, 17:15:35 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:15:35 INFO - 'talos_options': ['--stylo', 17:15:35 INFO - '--xperf_path', 17:15:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:35 INFO - 'tests': ['tp5n']}}} 17:15:35 INFO - Running post-action listener: _resource_record_post_action 17:15:35 INFO - [mozharness: 2017-08-26 00:15:35.048753Z] Finished populate-webroot step (success) 17:15:35 INFO - [mozharness: 2017-08-26 00:15:35.048842Z] Running create-virtualenv step. 17:15:35 INFO - Running pre-action listener: _resource_record_pre_action 17:15:35 INFO - Running main action method: create_virtualenv 17:15:35 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:35 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:15:35 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:15:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:15:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:35 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:35 INFO - Installing pip...............done. 17:15:35 INFO - Return code: 0 17:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:15:36 INFO - Reading from file tmpfile_stdout 17:15:36 INFO - Output received: 17:15:36 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:15:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:36 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')]} 17:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:36 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')]} 17:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:36 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:36 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 17:15:36 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 17:15:36 INFO - Using env: {'DISPLAY': ':0', 17:15:36 INFO - 'HOME': '/home/cltbld', 17:15:36 INFO - 'LANG': 'en_US.UTF-8', 17:15:36 INFO - 'LANGUAGE': 'en_US:en', 17:15:36 INFO - 'LOGNAME': 'cltbld', 17:15:36 INFO - 'MAIL': '/var/mail/cltbld', 17:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:36 INFO - 'MOZ_NO_REMOTE': '1', 17:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:36 INFO - 'NO_EM_RESTART': '1', 17:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:36 INFO - 'PWD': '/builds/slave/test', 17:15:36 INFO - 'SHELL': '/bin/bash', 17:15:36 INFO - 'SHLVL': '1', 17:15:36 INFO - 'TERM': 'linux', 17:15:36 INFO - 'TMOUT': '86400', 17:15:36 INFO - 'USER': 'cltbld', 17:15:36 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:36 INFO - '_': '/tools/buildbot/bin/python'} 17:15:37 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:15:37 INFO - Downloading/unpacking pip>=1.5 17:15:37 INFO - Running setup.py egg_info for package pip 17:15:37 INFO - warning: no files found matching 'pip/cacert.pem' 17:15:37 INFO - warning: no files found matching '*.html' under directory 'docs' 17:15:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:15:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:15:37 INFO - Installing collected packages: pip 17:15:37 INFO - Found existing installation: pip 1.1 17:15:37 INFO - Uninstalling pip: 17:15:37 INFO - Successfully uninstalled pip 17:15:37 INFO - Running setup.py install for pip 17:15:37 INFO - warning: no files found matching 'pip/cacert.pem' 17:15:37 INFO - warning: no files found matching '*.html' under directory 'docs' 17:15:37 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:15:37 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:15:37 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:15:37 INFO - Successfully installed pip 17:15:37 INFO - Cleaning up... 17:15:37 INFO - Return code: 0 17:15:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:37 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')]} 17:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:37 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')]} 17:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:37 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:37 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 17:15:37 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 17:15:37 INFO - Using env: {'DISPLAY': ':0', 17:15:37 INFO - 'HOME': '/home/cltbld', 17:15:37 INFO - 'LANG': 'en_US.UTF-8', 17:15:37 INFO - 'LANGUAGE': 'en_US:en', 17:15:37 INFO - 'LOGNAME': 'cltbld', 17:15:37 INFO - 'MAIL': '/var/mail/cltbld', 17:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:37 INFO - 'MOZ_NO_REMOTE': '1', 17:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:37 INFO - 'NO_EM_RESTART': '1', 17:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:37 INFO - 'PWD': '/builds/slave/test', 17:15:37 INFO - 'SHELL': '/bin/bash', 17:15:37 INFO - 'SHLVL': '1', 17:15:37 INFO - 'TERM': 'linux', 17:15:37 INFO - 'TMOUT': '86400', 17:15:37 INFO - 'USER': 'cltbld', 17:15:37 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:37 INFO - '_': '/tools/buildbot/bin/python'} 17:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:37 INFO - Downloading/unpacking psutil>=3.1.1 17:15:37 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 17:15:37 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 17:15:37 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 17:15:37 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 17:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:38 INFO - Installing collected packages: psutil 17:15:38 INFO - Running setup.py install for psutil 17:15:38 INFO - building 'psutil._psutil_linux' extension 17:15:38 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 17:15:38 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 17:15:38 INFO - building 'psutil._psutil_posix' extension 17:15:38 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 17:15:39 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 17:15:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:39 INFO - Successfully installed psutil 17:15:39 INFO - Cleaning up... 17:15:39 INFO - Return code: 0 17:15:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15: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')]} 17:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:39 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:39 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 17:15:39 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 17:15:39 INFO - Using env: {'DISPLAY': ':0', 17:15:39 INFO - 'HOME': '/home/cltbld', 17:15:39 INFO - 'LANG': 'en_US.UTF-8', 17:15:39 INFO - 'LANGUAGE': 'en_US:en', 17:15:39 INFO - 'LOGNAME': 'cltbld', 17:15:39 INFO - 'MAIL': '/var/mail/cltbld', 17:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:39 INFO - 'MOZ_NO_REMOTE': '1', 17:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:39 INFO - 'NO_EM_RESTART': '1', 17:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:39 INFO - 'PWD': '/builds/slave/test', 17:15:39 INFO - 'SHELL': '/bin/bash', 17:15:39 INFO - 'SHLVL': '1', 17:15:39 INFO - 'TERM': 'linux', 17:15:39 INFO - 'TMOUT': '86400', 17:15:39 INFO - 'USER': 'cltbld', 17:15:39 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:39 INFO - '_': '/tools/buildbot/bin/python'} 17:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:39 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 17:15:39 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 17:15:39 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 17:15:39 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 17:15:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:40 INFO - Installing collected packages: mozsystemmonitor 17:15:40 INFO - Running setup.py install for mozsystemmonitor 17:15:40 INFO - Successfully installed mozsystemmonitor 17:15:40 INFO - Cleaning up... 17:15:40 INFO - Return code: 0 17:15:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:40 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:40 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 17:15:40 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 17:15:40 INFO - Using env: {'DISPLAY': ':0', 17:15:40 INFO - 'HOME': '/home/cltbld', 17:15:40 INFO - 'LANG': 'en_US.UTF-8', 17:15:40 INFO - 'LANGUAGE': 'en_US:en', 17:15:40 INFO - 'LOGNAME': 'cltbld', 17:15:40 INFO - 'MAIL': '/var/mail/cltbld', 17:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:40 INFO - 'MOZ_NO_REMOTE': '1', 17:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:40 INFO - 'NO_EM_RESTART': '1', 17:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:40 INFO - 'PWD': '/builds/slave/test', 17:15:40 INFO - 'SHELL': '/bin/bash', 17:15:40 INFO - 'SHLVL': '1', 17:15:40 INFO - 'TERM': 'linux', 17:15:40 INFO - 'TMOUT': '86400', 17:15:40 INFO - 'USER': 'cltbld', 17:15:40 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:40 INFO - '_': '/tools/buildbot/bin/python'} 17:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:40 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:40 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 17:15:40 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 17:15:40 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 17:15:40 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 17:15:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:41 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 17:15:41 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 17:15:41 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 17:15:41 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 17:15:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:42 INFO - warning: no files found matching '*.txt' 17:15:42 INFO - no previously-included directories found matching 'build' 17:15:42 INFO - no previously-included directories found matching 'dist' 17:15:42 INFO - no previously-included directories found matching '.git*' 17:15:42 INFO - Installing collected packages: jsonschema, functools32 17:15:42 INFO - Running setup.py install for functools32 17:15:42 INFO - warning: no files found matching '*.txt' 17:15:42 INFO - no previously-included directories found matching 'build' 17:15:42 INFO - no previously-included directories found matching 'dist' 17:15:42 INFO - no previously-included directories found matching '.git*' 17:15:42 INFO - Successfully installed jsonschema functools32 17:15:42 INFO - Cleaning up... 17:15:42 INFO - Return code: 0 17:15:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:15:42 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')]} 17:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:42 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')]} 17:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:42 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:42 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 17:15:42 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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:15:42 INFO - Cleaning up... 17:15:42 INFO - Return code: 0 17:15:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:42 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')]} 17:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:42 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')]} 17:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:42 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:42 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 17:15:42 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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:42 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 17:15:42 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 17:15:42 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 17:15:42 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 17:15:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 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 17:15:44 INFO - Downloading docopt-0.6.1.tar.gz 17:15:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:44 INFO - Running setup.py install for blobuploader 17:15:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:44 INFO - Running setup.py install for requests 17:15:44 INFO - Running setup.py install for docopt 17:15:45 INFO - Successfully installed blobuploader requests docopt 17:15:45 INFO - Cleaning up... 17:15:45 INFO - Return code: 0 17:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15: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')]} 17:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:45 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:45 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 17:15:45 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 17:15:45 INFO - Using env: {'DISPLAY': ':0', 17:15:45 INFO - 'HOME': '/home/cltbld', 17:15:45 INFO - 'LANG': 'en_US.UTF-8', 17:15:45 INFO - 'LANGUAGE': 'en_US:en', 17:15:45 INFO - 'LOGNAME': 'cltbld', 17:15:45 INFO - 'MAIL': '/var/mail/cltbld', 17:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:45 INFO - 'MOZ_NO_REMOTE': '1', 17:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:45 INFO - 'NO_EM_RESTART': '1', 17:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:45 INFO - 'PWD': '/builds/slave/test', 17:15:45 INFO - 'SHELL': '/bin/bash', 17:15:45 INFO - 'SHLVL': '1', 17:15:45 INFO - 'TERM': 'linux', 17:15:45 INFO - 'TMOUT': '86400', 17:15:45 INFO - 'USER': 'cltbld', 17:15:45 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:45 INFO - '_': '/tools/buildbot/bin/python'} 17:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:45 INFO - Running setup.py (path:/tmp/pip-7S2ReE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:45 INFO - Running setup.py (path:/tmp/pip-B2bRhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:45 INFO - Running setup.py (path:/tmp/pip-R5WD7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:45 INFO - Running setup.py (path:/tmp/pip-s4uC2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:45 INFO - Running setup.py (path:/tmp/pip-_9vr7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:45 INFO - Running setup.py (path:/tmp/pip-I1N0q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:45 INFO - Running setup.py (path:/tmp/pip-cNRWsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:45 INFO - Running setup.py (path:/tmp/pip-WXj3tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:45 INFO - Running setup.py (path:/tmp/pip-DLy9mj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:45 INFO - Running setup.py (path:/tmp/pip-xBiwOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:45 INFO - Running setup.py (path:/tmp/pip-IjLRqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:46 INFO - Running setup.py (path:/tmp/pip-veBJDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:46 INFO - Running setup.py (path:/tmp/pip-JrI0WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:46 INFO - Running setup.py (path:/tmp/pip-5YP7p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:46 INFO - Running setup.py (path:/tmp/pip-MeIct9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:46 INFO - Running setup.py (path:/tmp/pip-CfrsBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:46 INFO - Running setup.py (path:/tmp/pip-D5xE8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:46 INFO - Running setup.py install for manifestparser 17:15:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:46 INFO - Running setup.py install for mozcrash 17:15:46 INFO - Running setup.py install for mozdebug 17:15:46 INFO - Running setup.py install for mozdevice 17:15:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:46 INFO - Running setup.py install for mozfile 17:15:46 INFO - Running setup.py install for mozhttpd 17:15:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for mozinfo 17:15:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for mozInstall 17:15:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for mozleak 17:15:47 INFO - Running setup.py install for mozlog 17:15:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for moznetwork 17:15:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for mozprocess 17:15:47 INFO - Running setup.py install for mozprofile 17:15:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for mozrunner 17:15:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:47 INFO - Running setup.py install for mozscreenshot 17:15:48 INFO - Running setup.py install for moztest 17:15:48 INFO - Running setup.py install for mozversion 17:15:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:48 INFO - Cleaning up... 17:15:48 INFO - Return code: 0 17:15:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:48 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:48 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 17:15:48 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 17:15:48 INFO - Using env: {'DISPLAY': ':0', 17:15:48 INFO - 'HOME': '/home/cltbld', 17:15:48 INFO - 'LANG': 'en_US.UTF-8', 17:15:48 INFO - 'LANGUAGE': 'en_US:en', 17:15:48 INFO - 'LOGNAME': 'cltbld', 17:15:48 INFO - 'MAIL': '/var/mail/cltbld', 17:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:48 INFO - 'MOZ_NO_REMOTE': '1', 17:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:48 INFO - 'NO_EM_RESTART': '1', 17:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:48 INFO - 'PWD': '/builds/slave/test', 17:15:48 INFO - 'SHELL': '/bin/bash', 17:15:48 INFO - 'SHLVL': '1', 17:15:48 INFO - 'TERM': 'linux', 17:15:48 INFO - 'TMOUT': '86400', 17:15:48 INFO - 'USER': 'cltbld', 17:15:48 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:48 INFO - '_': '/tools/buildbot/bin/python'} 17:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:48 INFO - Running setup.py (path:/tmp/pip-E0V_ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:48 INFO - Running setup.py (path:/tmp/pip-OF1F4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:48 INFO - Running setup.py (path:/tmp/pip-0p4Gn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:48 INFO - Running setup.py (path:/tmp/pip-K89ovm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:48 INFO - Running setup.py (path:/tmp/pip-nyOMco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:48 INFO - Running setup.py (path:/tmp/pip-8ISs8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:48 INFO - Running setup.py (path:/tmp/pip-zE3UgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:48 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)) 17:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:48 INFO - Running setup.py (path:/tmp/pip-fIjNut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:49 INFO - Running setup.py (path:/tmp/pip-WVnw33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:49 INFO - Running setup.py (path:/tmp/pip-R_BmeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:49 INFO - Running setup.py (path:/tmp/pip-k9OkGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:49 INFO - Running setup.py (path:/tmp/pip-1IX4d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:49 INFO - Running setup.py (path:/tmp/pip-pe8mky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:49 INFO - Running setup.py (path:/tmp/pip-PbI4lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:49 INFO - Running setup.py (path:/tmp/pip-kNjLzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:49 INFO - Running setup.py (path:/tmp/pip-YilWCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:49 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)) 17:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:49 INFO - Running setup.py (path:/tmp/pip-DHhxKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:49 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)) 17:15:49 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)) 17:15:49 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)) 17:15:49 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)) 17:15:49 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)) 17:15:49 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)) 17:15:49 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)) 17:15:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:50 INFO - Downloading blessings-1.6.tar.gz 17:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:50 INFO - Installing collected packages: blessings 17:15:50 INFO - Running setup.py install for blessings 17:15:50 INFO - Successfully installed blessings 17:15:50 INFO - Cleaning up... 17:15:51 INFO - Return code: 0 17:15:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:51 INFO - Reading from file tmpfile_stdout 17:15:51 INFO - Current package versions: 17:15:51 INFO - argparse == 1.2.1 17:15:51 INFO - blessings == 1.6 17:15:51 INFO - blobuploader == 1.2.4 17:15:51 INFO - docopt == 0.6.1 17:15:51 INFO - functools32 == 3.2.3-2 17:15:51 INFO - jsonschema == 2.5.1 17:15:51 INFO - manifestparser == 1.1 17:15:51 INFO - mozInstall == 1.13 17:15:51 INFO - mozcrash == 1.0 17:15:51 INFO - mozdebug == 0.1 17:15:51 INFO - mozdevice == 0.51 17:15:51 INFO - mozfile == 1.2 17:15:51 INFO - mozhttpd == 0.7 17:15:51 INFO - mozinfo == 0.10 17:15:51 INFO - mozleak == 0.1 17:15:51 INFO - mozlog == 3.5 17:15:51 INFO - moznetwork == 0.27 17:15:51 INFO - mozprocess == 0.25 17:15:51 INFO - mozprofile == 0.28 17:15:51 INFO - mozrunner == 6.13 17:15:51 INFO - mozscreenshot == 0.1 17:15:51 INFO - mozsystemmonitor == 0.3 17:15:51 INFO - moztest == 0.8 17:15:51 INFO - mozversion == 1.4 17:15:51 INFO - psutil == 3.1.1 17:15:51 INFO - requests == 1.2.3 17:15:51 INFO - wsgiref == 0.1.2 17:15:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:51 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')]} 17:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:51 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')]} 17:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:51 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:51 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 17:15:51 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 17:15:51 INFO - Using env: {'DISPLAY': ':0', 17:15:51 INFO - 'HOME': '/home/cltbld', 17:15:51 INFO - 'LANG': 'en_US.UTF-8', 17:15:51 INFO - 'LANGUAGE': 'en_US:en', 17:15:51 INFO - 'LOGNAME': 'cltbld', 17:15:51 INFO - 'MAIL': '/var/mail/cltbld', 17:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:51 INFO - 'MOZ_NO_REMOTE': '1', 17:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:51 INFO - 'NO_EM_RESTART': '1', 17:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:51 INFO - 'PWD': '/builds/slave/test', 17:15:51 INFO - 'SHELL': '/bin/bash', 17:15:51 INFO - 'SHLVL': '1', 17:15:51 INFO - 'TERM': 'linux', 17:15:51 INFO - 'TMOUT': '86400', 17:15:51 INFO - 'USER': 'cltbld', 17:15:51 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:51 INFO - '_': '/tools/buildbot/bin/python'} 17:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 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)) 17:15:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:15:52 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)) 17:15:52 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)) 17:15:52 INFO - Installing collected packages: simplejson 17:15:52 INFO - Running setup.py install for simplejson 17:15:52 INFO - building 'simplejson._speedups' extension 17:15:52 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 17:15:53 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 17:15:53 INFO - Successfully installed simplejson 17:15:53 INFO - Cleaning up... 17:15:53 INFO - Return code: 0 17:15:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:53 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 0x28031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b71f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, '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': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', '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 17:15:53 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 17:15:53 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 17:15:53 INFO - Using env: {'DISPLAY': ':0', 17:15:53 INFO - 'HOME': '/home/cltbld', 17:15:53 INFO - 'LANG': 'en_US.UTF-8', 17:15:53 INFO - 'LANGUAGE': 'en_US:en', 17:15:53 INFO - 'LOGNAME': 'cltbld', 17:15:53 INFO - 'MAIL': '/var/mail/cltbld', 17:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:53 INFO - 'MOZ_NO_REMOTE': '1', 17:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:53 INFO - 'NO_EM_RESTART': '1', 17:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:53 INFO - 'PWD': '/builds/slave/test', 17:15:53 INFO - 'SHELL': '/bin/bash', 17:15:53 INFO - 'SHLVL': '1', 17:15:53 INFO - 'TERM': 'linux', 17:15:53 INFO - 'TMOUT': '86400', 17:15:53 INFO - 'USER': 'cltbld', 17:15:53 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:53 INFO - '_': '/tools/buildbot/bin/python'} 17:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:15:53 INFO - Cleaning up... 17:15:53 INFO - Return code: 0 17:15:53 INFO - Running post-action listener: _resource_record_post_action 17:15:53 INFO - Running post-action listener: _start_resource_monitoring 17:15:53 INFO - Starting resource monitoring. 17:15:53 INFO - [mozharness: 2017-08-26 00:15:53.929923Z] Finished create-virtualenv step (success) 17:15:53 INFO - [mozharness: 2017-08-26 00:15:53.930451Z] Running install step. 17:15:53 INFO - Running pre-action listener: _resource_record_pre_action 17:15:53 INFO - Running main action method: install 17:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:54 INFO - Reading from file tmpfile_stdout 17:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:54 INFO - Reading from file tmpfile_stdout 17:15:54 INFO - Output received: 17:15:54 INFO - Usage: mozinstall [options] installer 17:15:54 INFO - Options: 17:15:54 INFO - -h, --help show this help message and exit 17:15:54 INFO - -d DEST, --destination=DEST 17:15:54 INFO - Directory to install application into. [default: 17:15:54 INFO - "/builds/slave/test"] 17:15:54 INFO - --app=APP Application being installed. [default: firefox] 17:15:54 INFO - mkdir: /builds/slave/test/build/application 17:15:54 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'] 17:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:16:12 INFO - Reading from file tmpfile_stdout 17:16:12 INFO - Output received: 17:16:12 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:12 INFO - Running post-action listener: _resource_record_post_action 17:16:12 INFO - [mozharness: 2017-08-26 00:16:12.046552Z] Finished install step (success) 17:16:12 INFO - [mozharness: 2017-08-26 00:16:12.046897Z] Running setup-mitmproxy step. 17:16:12 INFO - Running pre-action listener: _resource_record_pre_action 17:16:12 INFO - Running main action method: setup_mitmproxy 17:16:12 INFO - Skipping: mitmproxy is not required 17:16:12 INFO - Running post-action listener: _resource_record_post_action 17:16:12 INFO - [mozharness: 2017-08-26 00:16:12.048575Z] Finished setup-mitmproxy step (success) 17:16:12 INFO - [mozharness: 2017-08-26 00:16:12.048886Z] Running run-tests step. 17:16:12 INFO - Running pre-action listener: _resource_record_pre_action 17:16:12 INFO - Running pre-action listener: _set_gcov_prefix 17:16:12 INFO - Running main action method: run_tests 17:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:12 INFO - Python 2.7.3 17:16:12 INFO - Return code: 0 17:16:12 INFO - grabbing minidump binary from tooltool 17:16: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')]} 17:16:12 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 0x2b6f130>, '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 0x2b70030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b704c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:12 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 17:16:12 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 17:16:12 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 17:16:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:12 INFO - Return code: 0 17:16:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:12 INFO - ENV: RUST_BACKTRACE is now full 17:16:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:16:12 INFO - Using env: {'DISPLAY': ':0', 17:16:12 INFO - 'HOME': '/home/cltbld', 17:16:12 INFO - 'LANG': 'en_US.UTF-8', 17:16:12 INFO - 'LANGUAGE': 'en_US:en', 17:16:12 INFO - 'LOGNAME': 'cltbld', 17:16:12 INFO - 'MAIL': '/var/mail/cltbld', 17:16:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:12 INFO - 'MOZ_NO_REMOTE': '1', 17:16:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:12 INFO - 'NO_EM_RESTART': '1', 17:16:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:12 INFO - 'PWD': '/builds/slave/test', 17:16:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:12 INFO - 'RUST_BACKTRACE': 'full', 17:16:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:16:12 INFO - 'SHELL': '/bin/bash', 17:16:12 INFO - 'SHLVL': '1', 17:16:12 INFO - 'STYLO_FORCE_ENABLED': '1', 17:16:12 INFO - 'TERM': 'linux', 17:16:12 INFO - 'TMOUT': '86400', 17:16:12 INFO - 'USER': 'cltbld', 17:16:12 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:12 INFO - '_': '/tools/buildbot/bin/python'} 17:16:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:16:12 INFO - mozversion application_buildid: 20170825232216 17:16:12 INFO - mozversion application_changeset: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a 17:16:12 INFO - mozversion application_display_name: Nightly 17:16:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:12 INFO - mozversion application_name: Firefox 17:16:12 INFO - mozversion application_remotingname: firefox 17:16:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:16:12 INFO - mozversion application_vendor: Mozilla 17:16:12 INFO - mozversion application_version: 57.0a1 17:16:12 INFO - mozversion platform_buildid: 20170825232216 17:16:12 INFO - mozversion platform_changeset: 86a3c73984a23b1d524eadbd4a62b9b3fa27e46a 17:16:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:16:12 INFO - mozversion platform_version: 57.0a1 17:16:12 INFO - using testdate: 1503706572 17:16:12 INFO - actual date: 1503706572 17:16:12 INFO - starting webserver on 'localhost:51112' 17:16:12 INFO - SUITE-START | Running 2 tests 17:16:12 INFO - TEST-START | dromaeo_css 17:16:12 INFO - Initialising browser for dromaeo_css test... 17:16:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51112/getInfo.html -profile /tmp/tmpQ8NLuq/profile 17:16:12 INFO - TEST-INFO | started process 27814 (/builds/slave/test/build/application/firefox/firefox http://localhost:51112/getInfo.html) 17:16:18 INFO - TEST-INFO | 27814: exit 0 17:16:18 INFO - Browser initialized. 17:16:18 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:18 INFO - Using env: {'DISPLAY': ':0', 17:16:18 INFO - 'HOME': '/home/cltbld', 17:16:18 INFO - 'JSGC_DISABLE_POISONING': '1', 17:16:18 INFO - 'LANG': 'en_US.UTF-8', 17:16:18 INFO - 'LANGUAGE': 'en_US:en', 17:16:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:16:18 INFO - 'LOGNAME': 'cltbld', 17:16:18 INFO - 'MAIL': '/var/mail/cltbld', 17:16:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:18 INFO - 'MOZ_CRASHREPORTER': '1', 17:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:16:18 INFO - 'MOZ_NO_REMOTE': '1', 17:16:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:18 INFO - 'NO_EM_RESTART': '1', 17:16:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:18 INFO - 'PWD': '/builds/slave/test', 17:16:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:18 INFO - 'RUST_BACKTRACE': 'full', 17:16:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:16:18 INFO - 'SHELL': '/bin/bash', 17:16:18 INFO - 'SHLVL': '1', 17:16:18 INFO - 'STYLO_FORCE_ENABLED': '1', 17:16:18 INFO - 'TERM': 'linux', 17:16:18 INFO - 'TMOUT': '86400', 17:16:18 INFO - 'USER': 'cltbld', 17:16:18 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:18 INFO - '_': '/tools/buildbot/bin/python'} 17:16:18 INFO - TEST-INFO | started process 28001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ8NLuq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:19 INFO - PID 28001 | 17:16:19 INFO - PID 28001 | (/builds/slave/test/build/application/firefox/firefox:28050): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:16:19 INFO - PID 28001 | 17:16:20 INFO - PID 28001 | 17:16:20 INFO - PID 28001 | (/builds/slave/test/build/application/firefox/firefox:28110): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:16:20 INFO - PID 28001 | 17:16:20 INFO - PID 28001 | __metrics Screen width/height:1600/1200 17:16:20 INFO - PID 28001 | colorDepth:24 17:16:20 INFO - PID 28001 | Browser inner width/height: 1024/768 17:16:20 INFO - PID 28001 | __metrics 17:16:30 INFO - PID 28001 | RSS: Main: 174051328 17:16:30 INFO - PID 28001 | 17:19:29 INFO - PID 28001 | Cycle 1(1): loaded http://localhost:51112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51112/tests/dromaeo/cssquery-ext.html) 17:19:30 INFO - PID 28001 | RSS: Main: 178618368 17:19:30 INFO - PID 28001 | 17:22:32 INFO - PID 28001 | Cycle 1(1): loaded http://localhost:51112/tests/dromaeo/cssquery-ext.html (next: http://localhost:51112/tests/dromaeo/cssquery-jquery.html) 17:22:32 INFO - PID 28001 | RSS: Main: 172699648 17:22:32 INFO - PID 28001 | 17:25:34 INFO - PID 28001 | Cycle 1(1): loaded http://localhost:51112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51112/tests/dromaeo/cssquery-mootools.html) 17:25:35 INFO - PID 28001 | RSS: Main: 177774592 17:25:35 INFO - PID 28001 | 17:28:37 INFO - PID 28001 | Cycle 1(1): loaded http://localhost:51112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51112/tests/dromaeo/cssquery-prototype.html) 17:28:37 INFO - PID 28001 | RSS: Main: 175865856 17:28:37 INFO - PID 28001 | 17:31:41 INFO - PID 28001 | Cycle 1(1): loaded http://localhost:51112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51112/tests/dromaeo/cssquery-yui.html) 17:31:42 INFO - PID 28001 | RSS: Main: 179245056 17:31:42 INFO - PID 28001 | 17:34:43 INFO - PID 28001 | Cycle 1(1): loaded http://localhost:51112/tests/dromaeo/cssquery-yui.html (next: http://localhost:51112/tests/dromaeo/cssquery-dojo.html) 17:34:44 INFO - PID 28001 | RSS: Main: 179777536 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | __start_tp_report 17:34:44 INFO - PID 28001 | _x_x_mozilla_page_load 17:34:44 INFO - PID 28001 | _x_x_mozilla_page_load_details 17:34:44 INFO - PID 28001 | |i|pagename|runs| 17:34:44 INFO - PID 28001 | |0;dojo.html;3285.1294406982156;3326.168457885529;3335.4329763940127;3344.5150453184287;3387.085486918532;6290.842728931768;6359.5230357723185;6384.457321127704;6411.807645770628;6480.319566445514;6264.874702505947;6348.873022539547;6360.968195159029;6461.709223084972;6516.185476815398;5871.324797648283;5881.088431293157;5903.763849446028;5934.851628709295;5953.940460595382;836.4074977328951;5605.943940560604;5762.7406766695385;5841;5932.822015339547;5831.358550559435;5834.504067154276;5910.379410161936;5912.1722958785585;5912.586118971673;5808.738606762706;5833.212516310286;5902.085176797603;5909.704514774244;5932.525397968152;5816.796412125555;5818.2436283282905;5876.559258055663;5893.292804863444;5914.526837852962;6161.260648722182;6360.872782544369;6387.457066149383;6432.935670643281;6443.226812782449;6726;6731.596104233761;6764.932350676529;6824.761133360308;6843.520953533254;6909.239983601799;6917.412019978308;6940.583564986117;6945.72217111315;6955.93044069563;6334.3032266450655;6338.778142765027;6353.30113687494;6430.196225471816;6430.93569064308;6738.764143254963;6886.965565172142;6894.172699276019;6894.551854129466;6902.585844849325;6642.202935647753;6643.601383916884;6662.56693314933;6680.23177334603;6689.464842812563;6659.567128136656;6749.628770417674;6768.83077923046;6782.898256526156;6784.050232967388;6670.83322916931;6749.6962636681465;6819.147606549182;6819.761308354184;6825.35159159879;6230.563860529719;6670.566413183127;6693.163354580677;6696.564723293068;6717.832054198587;5096.286519887219;5101.8724531887;5104.642675012714;5112.6421150519855;5119.769610367543;4530.29780384041;4571.314302854598;4632.86101416958;4646.047560250141;4650.395448591729;5997.250343707036;5997.910031349533;6056.273247210275;6059.7273122709585;6065.727042283108;6692.86614267712;6798.66006699663;6800.8299792504595;6805.285445028299;6806.659667016629;5921.555883308769;5961.731722072517;5968.37332080134;5968.46283834457;5971.731272092679;5683.9715801420725;5725.398833122462;5733;5752.597318187771;5758.88482230353;6567.638779867058;6593.703283352261;6643.534952553371;6668.966655166791;6687.297833727486;6673.1992160941;6791.320867913367;6806.115205023315;6809.795706128824;6909.654517274217;6543.1821022372205;6543.476521878333;6556.573822701509;6566.409023187936;6566.671666416755;6583.835404114744;6730.8653826924165;6735.023421603742;6745.494087943326;6749.055132281583;6905.205901321211;6917.169939607279;6945.756898508528;6947.75682851118;6975.988481670231;6624.105745724266;6625.701843417154;6670.032845237511;6672.165979252593;6715.7985260442265;6467.353264673495;6617.139771829631;6623.370779775913;6703.128593282842;6724.529282950147;6519.08732777421;6521.576097553644;6576.506761992965;6601.108850305147;6618.338166183343;6688.866222675617;6699.363560461748;6727.26000139994;6749.527533072638;6776.966115169393;6334.714937827716;6398.424141827258;6450.612963222222;6537.5750576212395;6546.18172728409 17:34:44 INFO - PID 28001 | |1;ext.html;795.9005124359455;813.0609146435866;845.1506236232585;849.6813694864426;1126.4536699700639;29843.253918652044;31308.686913130863;39541.802290988504;40590;40644.18711625773;41544.169116617646;41946;41950.58049419505;42131.78934105325;42182;7416.295451932085;7602;7746.38028957682;8052.637631306576;8062.596870156469;7878.763637090897;7969.601519923981;7980.600969951508;7981.680732770682;7988.281054705076;7934.563599002081;7983.600819958979;7990.1610330915;7991.120976692559;7994.120646728855;7948.523088614673;7950.840983180333;7958.442908996372;7993.240642138988;7995.0805657349565;7883.290503854623;7897.407694422941;7929.603519823986;7929.762107136795;7939.682412703485;37330.253394932224;37613;37622;37640.62359376399;37781;3498.073010652179;3522.18989632386;3523.6652518010746;3524.8766293179615;3526.4533997230214;30553.69446305553;30560.84719576388;30599.235019124477;30604.693953060407;30617.38765224683;5251.474852514756;5258.55302299305;5279.815206467755;5285.497877701612;5301.0723123453245;179171;179333;179542;180118;180425.0978745111;45874.853128671384;46676.29985550219;47075.5292447078;47144.764276179085;47254.527454725016;49214.261786073235;49338.75330623324;49363.753181233864;49387.753061235184;49407.50592494029;14795.482158124414;14866.92566537182;14912.179830109448;14918.552443426715;14919.92540037293;10686.51910664022;10906;10910.181736369805;11773.764524709457;12042.698932526757;13539.11995720275;13580.592582222549;13610.366755989344;13655.180689158484;13737.381817818223;5379.919301210407;5408.323959505062;5433.185022246695;5563.972180139073;5718.228039214736;994.194702291132;1001.4542074569378;1009.1724785675675;1021.6322124035341;1027.8304079826894;22313.665295020586;27683.584746228822;28124.296892577848;28798.42403151925;29052.564211536843;1093.7375029992904;1094.141099237095;1101.0640955188187;1105.8341248812742;1108.9500972456258;12321.137520373488;12495.125341226027;12532.749345013232;12549.121561490609;12648.936755316348;248287;248983;249577;249908;250413;51878;52388.73805630948;52514.73742631339;52648.21027684588;52649.2102618461;1405.775075987837;1424.2451500704642;1433.519770876768;1436.2962148547138;1461.291273732239;22436;22592.774072259723;22619.547609048055;23052.538949220587;23205.88397058004;37526.43710344292;37691;37723.245535088594;37755.43366849444;37848;206115;206342;206487;207238;207439;29265.268368290963;29787.851060744557;33459.49810752792;33688.326233474705;33698.32603347969;42097.78951105225;42333.788331058146;42615.14769704651;42717.57282427136;43476.347854782834;31671;31706.524402134448;31832;31850.522242165924;31915;31051.844740776152;31150;31199.220019499695;31351.21621959469;32214;35014;35266.47100293549;35430.46854297136;35477.46783798194;35510;30448;30503.38993220079;30803.691963080084;30889.69110308868;31138.53292200664;23068.192613259125;23097.884510578013;23203.767962320835;23310.53378932378;23356.76643233546 17:34:44 INFO - PID 28001 | |2;jquery.html;562.6258538072182;562.7833284185588;565.9151127330903;575.8790653962668;586.6685322792622;22207.1117155314;22519.324420267396;23306.4173395665;23308.5338293234;23324.183653572127;22639;24435.266941991726;24484.755152448513;24575.508489830194;24620.26139215822;7121.928780712191;7306.415486761046;7308.890366644505;7309.451791115661;7310.926890731104;6379.553431259814;7079.964600176992;7081.150261968545;7093.858122837541;7293.817654558652;7030.121234845645;7048.18945821232;7048.964755176243;7050.788476345718;7054.964725176367;7043.190033146177;7057.89413158803;7058.329458701415;7067.646617669147;7071.186813516409;6921.411680007205;6922.134733158356;6932.341427564424;6935.237123916365;6941;30284.394312113633;31082.22294442657;31569.36861262762;31698;31705.682943170505;2102.7266455360705;2128.1487405037956;2136.327056977047;2138.3691810915816;2138.5295235048266;20328.593428131353;21108.522403431765;21138.577228455346;21141.788582114135;21146.788532114635;2486.925392238236;2490.2778194323623;2562.5515534781525;2583.870806459688;2585.4312051348675;138762.30618846943;142775;143188;143394;143401;19105.21160266293;21029.579408411748;21299.78700213009;21418.464538386666;21466.892665536572;41930.37104443436;42125;42150.578494214664;42226.577734222265;42257.78871105686;11082.390468524309;11115.944420277847;11127.777444451227;11255.324680519032;11391.772164556662;8230.300424463869;9212.170904618617;9236.261099112055;9305.720828375159;9334.813303733887;9169.449833010041;10887.891121088687;10896.346219226712;11289.266197697123;11526.308421494738;3668.596454390015;3835.6356146166067;4111.8972025699595;4224.177952606579;4292.5707429257445;913.1462082952461;947.6398968392105;970.9951450242703;972.8151651186251;983.6655537117272;19088.71366929497;19771.802281977285;23092.884535577214;23250.65124023141;23501.17745878886;981.1169947047714;1026.4354604967386;1031.3141760729031;1034.1364960258268;1037.984430233547;11032.44837758109;11315.886841131483;11353.659390218307;11363.545458181745;11479.426028698532;499450;515929;516156;532585;535693;120186.39906800585;122812.38593807153;122816.38591806983;125085.37457312655;125535.37232313963;1204.1275963081325;1214.0409076829205;1215.9756804863853;1236.8577613574373;1241.0381953985734;18492.630147397245;18510.722339164655;18860.151293192113;21131.366059018255;22297.77702222957;58739;59290;60089.09866351921;61099.38900610937;61908;67962.66018669875;68467;68811;68886.31113689;68898.65550672215;14385.928070359581;14862;14866.554003379915;14944.775828362366;15092.773608395662;23152.305430837103;23362.415939600967;23610;23693.763062369155;23781.167659131846;18376.356827510972;18528.44414667562;18546;18685.15916783721;18700.345487908402;15978.760318595463;16276.267567959707;16300.184990750653;16712.66574668524;17366.305347785947;16660;18981.905090474458;19456.221751129797;19555.70666439976;19605.50986225356;14730.189839558927;14795.926020369829;14825.110493370432;14827;14896.478623248135;18200.726989095438;18559.628807424047;18651.160697768904;18658.067096645384;18725 17:34:44 INFO - PID 28001 | |3;mootools.html;1301.7461594988974;1354.3634491788855;1374.9037567370287;1376.9655758606027;1380.9516666916657;14498;14660.560183194495;15355.155466449341;15355.385784568633;15363.385464581417;15709;15881.841181588181;15935.681286374265;15955.042697438163;15955.282012309444;2774.4728501584686;2812.2406950123454;2815.6761972373133;2823.9294017649518;2826.943461130776;2698.8380697158136;2719.7008329083783;2759.503289407916;2761.5443451830524;2763.1848604661573;2699.217227004176;2732.412531305769;2794.2874566985392;2794.4271424357958;2796.748292653661;2636.182783337162;2667;2667.8932842686268;2668.679758429001;2668.83986960781;2632.2234940692542;2640.93397665058;2642.471505698868;2647.9205623831317;2656.8671566421604;14418.711625767426;14758.335874885548;14759.852401475955;14801.851981480155;14813.629659258497;7713.6914523419;7968;8002.559859207741;8005.6797728090805;8009.9199008009755;5177.352830896138;5397.082495975694;5495.53287970523;5503.3120859892515;5523.558115350803;1899.629572233415;1946.4939115829845;1955.7555305586802;1998.99000504998;2005.5587770690424;24692.629610555858;24939.251822445356;24945.750542494523;24952.251432456873;24958.750412496007;6469.838254043687;6490.188726409199;6586.538942274091;6651.268360480343;6713.798586042427;15864.206789660471;15873.444429444913;15877.920610396874;15889.046657200604;15897.920510397606;7292.088488938883;7444.292792184734;7449.515781474187;7458.291462311072;7461.440391970624;5786;5805.912911306334;5961.821145365646;6252.280987686474;7285.635718214068;5077.162268225775;5207.427183009866;5216.60875434344;5246.396664383568;5300.621838322064;1503.7368460519365;1536.9077855328717;1537.6155961009747;1547.6440418703762;1551.0538571471393;894.0969620683027;908.6229214875884;930.7952250504878;938.7746940734174;942.6323733743845;7846.725364612325;7858.882116768253;7967.203279672102;7972.521648701097;9092.136247056518;982.3761911186448;987.2496902354262;992.6228033347281;993.450217660452;1013.1843865688045;5193.2989046479;5485.177223416519;5543.861403464865;5560.304961879765;5664.348599911063;19867.205311787657;20144.294949676692;20586.691199632016;20638.58722825535;20674.173033078507;20060.69908951367;20134.69797953032;20243.595128097357;20271.898640506704;20279.594408111756;10223.386596804066;11276.267042642367;11357.091432685365;11370.545178192946;11384.943075284737;8527.786805329917;8756.299496040174;8839.779005524913;8995.910040899507;9315.767105822408;17303.221355039306;17873.463796086136;17912;18251.269949201884;18314.45056648303;17922.372716954844;18268.72596911074;18340.17469213862;18356.632867342847;18581;13356.933215333862;13576.1854288743;13653.453861845415;14041.859581404464;14159.433622654979;13726.794098088338;13893.652658683613;13894.305284735925;13894.652633684238;13902.23537705436;10877.966593173636;10965.945170274417;11024.944875275572;11027.724306892393;11169.050630696482;10570.41862697559;10720.571177153139;11835.64493065175;11903.10726695484;11938;10127;10339.689809305733;10345.948270258601;10345.948270258901;10354.689359319233;7540.245975402416;7593.696252150073;7673.8465230693955;7687.2697093776005;7717.382609391123;7234.891476627749;7275.199728030018;7282.96358518204;7289.890651640124;7349.228331025165 17:34:44 INFO - PID 28001 | |4;prototype.html;501.99749001254986;506.5213373362173;520.6459607466923;525.1964494323684;531.2509361799861;6344.65247858292;6412.903806442907;6441.777586732575;6445.323241059691;6446.45205157561;6296;6326.968365158168;6346.968265158679;6379.341371243487;6396.616203027822;5170.9741451292875;5277.604179686519;5290.7354632268425;5292.100342941709;5314.388845282784;5290.470952904717;5328.307320048389;5332.786688532454;5364.865878353034;5403.1089118808295;5312.92030619541;5319.228711836781;5354.544863686591;5368.8389348319615;5381.488758567949;5281.313429254211;5312.548433383167;5336.932613477281;5360.571154307646;5363.758630861621;4908.950910490885;4924.113659541281;4976.4525902150735;4984.102861484931;5013.74656335916;6295.433410992987;6378.904316435211;6440.51696122788;6441.194850643669;6476.481881449473;6073.878522429571;6120.234970628671;6158.3841615838055;6168.784092556783;6192.566520343577;6827.863442731167;6834.6582670866255;6856.211535673411;6875.518713690044;6885.380315771555;5340;5358.973205133989;5383;5408.621396502246;5429.701366424845;6715.3620406061345;6763.526553141282;6993.545419547713;6993.545419547713;7087.468439867031;5504.119340905436;5517.751701173457;5544.16837474374;5568.777248909998;5590.720463976785;5615.410381909923;5619.8876022480135;5623.381428042912;5630.296212973379;5652.236948012048;6032.819015429544;6049.425304596057;6053.818385448443;6079.787207447718;6138.907916381258;6838.384545390939;6840.845133782843;6882.346177113166;6893.965530172417;6916;1979.8119178678003;1994.1126198841666;2000.759908810952;2006.2946495478727;2006.6287736768745;1393.2197969137314;1434.8493408192198;1436.978445323321;1467.229704405196;1476.0848274070145;5907.822765317047;5917.911231331534;5957.79147729836;5974.133750606225;6006.819795406145;6748.831279218059;6767.695453704595;6799.218089919723;6805.353491418307;6870.587764734132;5946.0675280534;5971.164037034819;5977.6114552553945;5984.551158663117;5993.61041532299;3620.873269435557;3632.328019316435;3650.634936506328;3661.761985470936;3705.8517659293866;6623.536352455282;6707.262201157869;6708.530402871752;6747.426468750113;6758.966205169041;6871.4502839772695;6940.895886561706;7051.92948070523;7128.857422851514;7164.928350716426;6620;6633.635150066792;6656.167979002625;6659.334066593399;6696.7656132035145;6711.228208756055;6726.8654626908165;6781.084553585203;6809.8638027238185;6874.793756187322;6797.762078327235;6812;6818.659067046727;6853.520253582401;6981.441484681315;6552.460171859514;6607.471402287902;6641.269460359454;6673.632950187592;6683.699233534599;5548.306461692288;5554.500094991308;5579.163125531203;5580.35825880029;5612.382637909908;6565.967170164118;6610.933890661032;6655.434288085373;6780.321967803377;6952.652367381712;6502.252240992158;6588.562231974201;6633.2371777246235;6654.334566543307;6656.800295991128;6494.155759751202;6545.705443254969;6637.867242655217;6658.933410666025;6676.298988606127;6481.773137940149;6551.934480655133;6561.3438656134;6619.505810177638;6722.226943901514;6693.230278518033;6716.966415167893;6730.394264516217;6736.494762892705;6759.391654751096;6525.282218956006;6533.509986750918;6557.344265573404;6557.508186885907;6564.770233042012 17:34:44 INFO - PID 28001 | |5;yui.html;873.8776571280022;881.8500854854675;896.0815164456434;897.5063714956772;901.8286525560143;18434.63130737386;19286.51783705408;19297.90351048243;19367.322143724974;21950.670739938872;19560;19997;20203.090860911256;20220.898895505503;20263.696044559343;921.7465197070826;922.2253307221915;928.8467402878517;929.330881765128;929.4005366538579;942.6842007927353;943.8772959515253;943.8772959515253;945.3902233059672;951.0917074194163;951.8001219743862;987.6395115782724;990.8761404824397;992.3748038735587;995.7809281957993;982.4891056650538;984.2716389871515;984.3896783993933;984.7095106943398;985.4038306824375;711.7010855440727;712.2130046298817;712.3482013957223;713.062323045199;719.586237913202;18174.382300425896;18507.907460462746;18610.90694546532;18707.53231169218;18709.345172918882;21172.89413552938;21353.679694804592;21731.456713582287;21770.89114554417;21792.891035544722;16331.591710207222;16437.753433698505;16465.094419806905;16468.42360517376;17479.21343539531;3803.2013277211818;3838.2899163654815;3838.846446142151;3841.2701586698436;3849.2878817418587;116542;125844;126232;127732.36133819271;130000;16540.338386464646;16591.170441477876;16972.575685607957;17030.659386812193;17057.829421705625;28481.430371392456;30139.397212055635;30150.396992060036;30173.547396789065;30174.245643859078;7714.961425192951;8061.637226324712;8794.208521232991;8899.866502002475;9081.54592270384;4327.0480494291205;4437.068215674744;4446.3108218226225;4458.598726114666;4460.553944605514;4952.232403977389;5023.673461225008;5071.847844564669;5092.567131793839;5095.159298715745;1085.8208395614793;1099.8460215569826;1112.232559533919;1113.4098927568402;1116.1015382616908;685.0819901332139;702.8032150997728;711.0969069282087;715.3561794384991;718.6299055986171;11767.941160294315;11892.037544348146;11930.940345298219;11946.522139114339;12561.748765024648;693.4036728413561;710.5345998370972;711.0969069282087;711.3704371631144;716.8530451257479;6109.786157484556;6124.816255512342;6320.512436170278;6397.872042559123;6508.284088750233;114111.42944285226;114399.42800285945;114836;116483.41758291154;117392;91699;92396;93737.531312343;95399;96173;86985.56507217423;88784.5560772192;90037.54981225052;91191;91730.54134729283;11817.05018671944;12782.68043298925;13002.154859934075;13067.215967042008;13102.213867168;40979;41429.378559322235;41508;41995.58004419917;43670.344944825214;72483.63758181386;72653.636731816;73654.63172684102;74031.25968740458;75168;18230.908845455688;18920.148593313057;18965.71551426702;19024.904875476088;19035;17110.572235694206;17501.21244544024;20274.364668147053;20941.685874712195;21438.892805535874;18470.907645461688;18575.44273671792;18680.626387471904;18926.621467570298;19500;17841;17873.463796086136;19177.232910683975;19471.22115115436;19644.312449064215;16111.355545778037;16450.259738311564;17969.640607188045;17990.280388784304;18947.621047579247;13968.301584920917;14053;14098.718025639635;14468.565943021726;14758.409663613334;13977.650558736113;14213;14224.217668027944;14284.07153535017;14287.57137285883 17:34:44 INFO - PID 28001 | __end_tp_report 17:34:44 INFO - PID 28001 | __start_cc_report 17:34:44 INFO - PID 28001 | _x_x_mozilla_cycle_collect,387 17:34:44 INFO - PID 28001 | __end_cc_report 17:34:44 INFO - PID 28001 | __startTimestamp1503707684074__endTimestamp 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | ------- Summary: start ------- 17:34:44 INFO - PID 28001 | Number of tests: 6 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | [#0] dojo.html Cycles:165 Average:6225.10 Median:6543.18 stddev:851.52 (13.0%) stddev-sans-first:822.31 17:34:44 INFO - PID 28001 | Values: 3285.1 3326.2 3335.4 3344.5 3387.1 6290.8 6359.5 6384.5 6411.8 6480.3 6264.9 6348.9 6361.0 6461.7 6516.2 5871.3 5881.1 5903.8 5934.9 5953.9 836.4 5605.9 5762.7 5841.0 5932.8 5831.4 5834.5 5910.4 5912.2 5912.6 5808.7 5833.2 5902.1 5909.7 5932.5 5816.8 5818.2 5876.6 5893.3 5914.5 6161.3 6360.9 6387.5 6432.9 6443.2 6726.0 6731.6 6764.9 6824.8 6843.5 6909.2 6917.4 6940.6 6945.7 6955.9 6334.3 6338.8 6353.3 6430.2 6430.9 6738.8 6887.0 6894.2 6894.6 6902.6 6642.2 6643.6 6662.6 6680.2 6689.5 6659.6 6749.6 6768.8 6782.9 6784.1 6670.8 6749.7 6819.1 6819.8 6825.4 6230.6 6670.6 6693.2 6696.6 6717.8 5096.3 5101.9 5104.6 5112.6 5119.8 4530.3 4571.3 4632.9 4646.0 4650.4 5997.3 5997.9 6056.3 6059.7 6065.7 6692.9 6798.7 6800.8 6805.3 6806.7 5921.6 5961.7 5968.4 5968.5 5971.7 5684.0 5725.4 5733.0 5752.6 5758.9 6567.6 6593.7 6643.5 6669.0 6687.3 6673.2 6791.3 6806.1 6809.8 6909.7 6543.2 6543.5 6556.6 6566.4 6566.7 6583.8 6730.9 6735.0 6745.5 6749.1 6905.2 6917.2 6945.8 6947.8 6976.0 6624.1 6625.7 6670.0 6672.2 6715.8 6467.4 6617.1 6623.4 6703.1 6724.5 6519.1 6521.6 6576.5 6601.1 6618.3 6688.9 6699.4 6727.3 6749.5 6777.0 6334.7 6398.4 6450.6 6537.6 6546.2 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | [#1] ext.html Cycles:180 Average:37676.94 Median:33693.33 stddev:55511.74 (164.8%) stddev-sans-first:55598.39 17:34:44 INFO - PID 28001 | Values: 795.9 813.1 845.2 849.7 1126.5 29843.3 31308.7 39541.8 40590.0 40644.2 41544.2 41946.0 41950.6 42131.8 42182.0 7416.3 7602.0 7746.4 8052.6 8062.6 7878.8 7969.6 7980.6 7981.7 7988.3 7934.6 7983.6 7990.2 7991.1 7994.1 7948.5 7950.8 7958.4 7993.2 7995.1 7883.3 7897.4 7929.6 7929.8 7939.7 37330.3 37613.0 37622.0 37640.6 37781.0 3498.1 3522.2 3523.7 3524.9 3526.5 30553.7 30560.8 30599.2 30604.7 30617.4 5251.5 5258.6 5279.8 5285.5 5301.1 179171.0 179333.0 179542.0 180118.0 180425.1 45874.9 46676.3 47075.5 47144.8 47254.5 49214.3 49338.8 49363.8 49387.8 49407.5 14795.5 14866.9 14912.2 14918.6 14919.9 10686.5 10906.0 10910.2 11773.8 12042.7 13539.1 13580.6 13610.4 13655.2 13737.4 5379.9 5408.3 5433.2 5564.0 5718.2 994.2 1001.5 1009.2 1021.6 1027.8 22313.7 27683.6 28124.3 28798.4 29052.6 1093.7 1094.1 1101.1 1105.8 1109.0 12321.1 12495.1 12532.7 12549.1 12648.9 248287.0 248983.0 249577.0 249908.0 250413.0 51878.0 52388.7 52514.7 52648.2 52649.2 1405.8 1424.2 1433.5 1436.3 1461.3 22436.0 22592.8 22619.5 23052.5 23205.9 37526.4 37691.0 37723.2 37755.4 37848.0 206115.0 206342.0 206487.0 207238.0 207439.0 29265.3 29787.9 33459.5 33688.3 33698.3 42097.8 42333.8 42615.1 42717.6 43476.3 31671.0 31706.5 31832.0 31850.5 31915.0 31051.8 31150.0 31199.2 31351.2 32214.0 35014.0 35266.5 35430.5 35477.5 35510.0 30448.0 30503.4 30803.7 30889.7 31138.5 23068.2 23097.9 23203.8 23310.5 23356.8 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | [#2] jquery.html Cycles:180 Average:37057.39 Median:23278.53 stddev:87412.36 (375.5%) stddev-sans-first:87614.63 17:34:44 INFO - PID 28001 | Values: 562.6 562.8 565.9 575.9 586.7 22207.1 22519.3 23306.4 23308.5 23324.2 22639.0 24435.3 24484.8 24575.5 24620.3 7121.9 7306.4 7308.9 7309.5 7310.9 6379.6 7080.0 7081.2 7093.9 7293.8 7030.1 7048.2 7049.0 7050.8 7055.0 7043.2 7057.9 7058.3 7067.6 7071.2 6921.4 6922.1 6932.3 6935.2 6941.0 30284.4 31082.2 31569.4 31698.0 31705.7 2102.7 2128.1 2136.3 2138.4 2138.5 20328.6 21108.5 21138.6 21141.8 21146.8 2486.9 2490.3 2562.6 2583.9 2585.4 138762.3 142775.0 143188.0 143394.0 143401.0 19105.2 21029.6 21299.8 21418.5 21466.9 41930.4 42125.0 42150.6 42226.6 42257.8 11082.4 11115.9 11127.8 11255.3 11391.8 8230.3 9212.2 9236.3 9305.7 9334.8 9169.4 10887.9 10896.3 11289.3 11526.3 3668.6 3835.6 4111.9 4224.2 4292.6 913.1 947.6 971.0 972.8 983.7 19088.7 19771.8 23092.9 23250.7 23501.2 981.1 1026.4 1031.3 1034.1 1038.0 11032.4 11315.9 11353.7 11363.5 11479.4 499450.0 515929.0 516156.0 532585.0 535693.0 120186.4 122812.4 122816.4 125085.4 125535.4 1204.1 1214.0 1216.0 1236.9 1241.0 18492.6 18510.7 18860.2 21131.4 22297.8 58739.0 59290.0 60089.1 61099.4 61908.0 67962.7 68467.0 68811.0 68886.3 68898.7 14385.9 14862.0 14866.6 14944.8 15092.8 23152.3 23362.4 23610.0 23693.8 23781.2 18376.4 18528.4 18546.0 18685.2 18700.3 15978.8 16276.3 16300.2 16712.7 17366.3 16660.0 18981.9 19456.2 19555.7 19605.5 14730.2 14795.9 14825.1 14827.0 14896.5 18200.7 18559.6 18651.2 18658.1 18725.0 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | [#3] mootools.html Cycles:180 Average:9203.18 Median:13795.49 stddev:6369.87 (46.2%) stddev-sans-first:6360.07 17:34:44 INFO - PID 28001 | Values: 1301.7 1354.4 1374.9 1377.0 1381.0 14498.0 14660.6 15355.2 15355.4 15363.4 15709.0 15881.8 15935.7 15955.0 15955.3 2774.5 2812.2 2815.7 2823.9 2826.9 2698.8 2719.7 2759.5 2761.5 2763.2 2699.2 2732.4 2794.3 2794.4 2796.7 2636.2 2667.0 2667.9 2668.7 2668.8 2632.2 2640.9 2642.5 2647.9 2656.9 14418.7 14758.3 14759.9 14801.9 14813.6 7713.7 7968.0 8002.6 8005.7 8009.9 5177.4 5397.1 5495.5 5503.3 5523.6 1899.6 1946.5 1955.8 1999.0 2005.6 24692.6 24939.3 24945.8 24952.3 24958.8 6469.8 6490.2 6586.5 6651.3 6713.8 15864.2 15873.4 15877.9 15889.0 15897.9 7292.1 7444.3 7449.5 7458.3 7461.4 5786.0 5805.9 5961.8 6252.3 7285.6 5077.2 5207.4 5216.6 5246.4 5300.6 1503.7 1536.9 1537.6 1547.6 1551.1 894.1 908.6 930.8 938.8 942.6 7846.7 7858.9 7967.2 7972.5 9092.1 982.4 987.2 992.6 993.5 1013.2 5193.3 5485.2 5543.9 5560.3 5664.3 19867.2 20144.3 20586.7 20638.6 20674.2 20060.7 20134.7 20243.6 20271.9 20279.6 10223.4 11276.3 11357.1 11370.5 11384.9 8527.8 8756.3 8839.8 8995.9 9315.8 17303.2 17873.5 17912.0 18251.3 18314.5 17922.4 18268.7 18340.2 18356.6 18581.0 13356.9 13576.2 13653.5 14041.9 14159.4 13726.8 13893.7 13894.3 13894.7 13902.2 10878.0 10965.9 11024.9 11027.7 11169.1 10570.4 10720.6 11835.6 11903.1 11938.0 10127.0 10339.7 10345.9 10345.9 10354.7 7540.2 7593.7 7673.8 7687.3 7717.4 7234.9 7275.2 7283.0 7289.9 7349.2 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | [#4] prototype.html Cycles:180 Average:5755.40 Median:6379.12 stddev:1529.38 (24.0%) stddev-sans-first:1481.96 17:34:44 INFO - PID 28001 | Values: 502.0 506.5 520.6 525.2 531.3 6344.7 6412.9 6441.8 6445.3 6446.5 6296.0 6327.0 6347.0 6379.3 6396.6 5171.0 5277.6 5290.7 5292.1 5314.4 5290.5 5328.3 5332.8 5364.9 5403.1 5312.9 5319.2 5354.5 5368.8 5381.5 5281.3 5312.5 5336.9 5360.6 5363.8 4909.0 4924.1 4976.5 4984.1 5013.7 6295.4 6378.9 6440.5 6441.2 6476.5 6073.9 6120.2 6158.4 6168.8 6192.6 6827.9 6834.7 6856.2 6875.5 6885.4 5340.0 5359.0 5383.0 5408.6 5429.7 6715.4 6763.5 6993.5 6993.5 7087.5 5504.1 5517.8 5544.2 5568.8 5590.7 5615.4 5619.9 5623.4 5630.3 5652.2 6032.8 6049.4 6053.8 6079.8 6138.9 6838.4 6840.8 6882.3 6894.0 6916.0 1979.8 1994.1 2000.8 2006.3 2006.6 1393.2 1434.8 1437.0 1467.2 1476.1 5907.8 5917.9 5957.8 5974.1 6006.8 6748.8 6767.7 6799.2 6805.4 6870.6 5946.1 5971.2 5977.6 5984.6 5993.6 3620.9 3632.3 3650.6 3661.8 3705.9 6623.5 6707.3 6708.5 6747.4 6759.0 6871.5 6940.9 7051.9 7128.9 7164.9 6620.0 6633.6 6656.2 6659.3 6696.8 6711.2 6726.9 6781.1 6809.9 6874.8 6797.8 6812.0 6818.7 6853.5 6981.4 6552.5 6607.5 6641.3 6673.6 6683.7 5548.3 5554.5 5579.2 5580.4 5612.4 6566.0 6610.9 6655.4 6780.3 6952.7 6502.3 6588.6 6633.2 6654.3 6656.8 6494.2 6545.7 6637.9 6658.9 6676.3 6481.8 6551.9 6561.3 6619.5 6722.2 6693.2 6717.0 6730.4 6736.5 6759.4 6525.3 6533.5 6557.3 6557.5 6564.8 17:34:44 INFO - PID 28001 | 17:34:44 INFO - PID 28001 | [#5] yui.html Cycles:180 Average:24047.42 Median:29310.41 stddev:32566.34 (111.1%) stddev-sans-first:32611.21 17:34:44 INFO - PID 28001 | Values: 873.9 881.9 896.1 897.5 901.8 18434.6 19286.5 19297.9 19367.3 21950.7 19560.0 19997.0 20203.1 20220.9 20263.7 921.7 922.2 928.8 929.3 929.4 942.7 943.9 943.9 945.4 951.1 951.8 987.6 990.9 992.4 995.8 982.5 984.3 984.4 984.7 985.4 711.7 712.2 712.3 713.1 719.6 18174.4 18507.9 18610.9 18707.5 18709.3 21172.9 21353.7 21731.5 21770.9 21792.9 16331.6 16437.8 16465.1 16468.4 17479.2 3803.2 3838.3 3838.8 3841.3 3849.3 116542.0 125844.0 126232.0 127732.4 130000.0 16540.3 16591.2 16972.6 17030.7 17057.8 28481.4 30139.4 30150.4 30173.5 30174.2 7715.0 8061.6 8794.2 8899.9 9081.5 4327.0 4437.1 4446.3 4458.6 4460.6 4952.2 5023.7 5071.8 5092.6 5095.2 1085.8 1099.8 1112.2 1113.4 1116.1 685.1 702.8 711.1 715.4 718.6 11767.9 11892.0 11930.9 11946.5 12561.7 693.4 710.5 711.1 711.4 716.9 6109.8 6124.8 6320.5 6397.9 6508.3 114111.4 114399.4 114836.0 116483.4 117392.0 91699.0 92396.0 93737.5 95399.0 96173.0 86985.6 88784.6 90037.5 91191.0 91730.5 11817.1 12782.7 13002.2 13067.2 13102.2 40979.0 41429.4 41508.0 41995.6 43670.3 72483.6 72653.6 73654.6 74031.3 75168.0 18230.9 18920.1 18965.7 19024.9 19035.0 17110.6 17501.2 20274.4 20941.7 21438.9 18470.9 18575.4 18680.6 18926.6 19500.0 17841.0 17873.5 19177.2 19471.2 19644.3 16111.4 16450.3 17969.6 17990.3 18947.6 13968.3 14053.0 14098.7 14468.6 14758.4 13977.7 14213.0 14224.2 14284.1 14287.6 17:34:44 INFO - PID 28001 | -------- Summary: end -------- 17:34:44 INFO - PID 28001 | 17:34:44 INFO - TEST-INFO | 28001: exit 0 17:34:44 INFO - TEST-OK | dromaeo_css | took 1112491ms 17:34:44 INFO - TEST-START | kraken 17:34:44 INFO - Initialising browser for kraken test... 17:34:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51112/getInfo.html -profile /tmp/tmpgbXprd/profile 17:34:44 INFO - TEST-INFO | started process 28423 (/builds/slave/test/build/application/firefox/firefox http://localhost:51112/getInfo.html) 17:34:50 INFO - TEST-INFO | 28423: exit 0 17:34:51 INFO - Browser initialized. 17:34:51 INFO - Running cycle 1/1 for kraken test... 17:34:51 INFO - Using env: {'DISPLAY': ':0', 17:34:51 INFO - 'HOME': '/home/cltbld', 17:34:51 INFO - 'JSGC_DISABLE_POISONING': '1', 17:34:51 INFO - 'LANG': 'en_US.UTF-8', 17:34:51 INFO - 'LANGUAGE': 'en_US:en', 17:34:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:34:51 INFO - 'LOGNAME': 'cltbld', 17:34:51 INFO - 'MAIL': '/var/mail/cltbld', 17:34:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:34:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:34:51 INFO - 'MOZ_CRASHREPORTER': '1', 17:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:34:51 INFO - 'MOZ_NO_REMOTE': '1', 17:34:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:51 INFO - 'NO_EM_RESTART': '1', 17:34:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:51 INFO - 'PWD': '/builds/slave/test', 17:34:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:34:51 INFO - 'RUST_BACKTRACE': 'full', 17:34:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:34:51 INFO - 'SHELL': '/bin/bash', 17:34:51 INFO - 'SHLVL': '1', 17:34:51 INFO - 'STYLO_FORCE_ENABLED': '1', 17:34:51 INFO - 'TERM': 'linux', 17:34:51 INFO - 'TMOUT': '86400', 17:34:51 INFO - 'USER': 'cltbld', 17:34:51 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500', 17:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:51 INFO - '_': '/tools/buildbot/bin/python'} 17:34:51 INFO - TEST-INFO | started process 28612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgbXprd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:52 INFO - PID 28612 | 17:34:52 INFO - PID 28612 | (/builds/slave/test/build/application/firefox/firefox:28661): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:34:52 INFO - PID 28612 | 17:34:52 INFO - PID 28612 | 17:34:52 INFO - PID 28612 | (/builds/slave/test/build/application/firefox/firefox:28722): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:34:52 INFO - PID 28612 | 17:34:52 INFO - PID 28612 | __metrics Screen width/height:1600/1200 17:34:52 INFO - PID 28612 | colorDepth:24 17:34:52 INFO - PID 28612 | Browser inner width/height: 1024/768 17:34:52 INFO - PID 28612 | __metrics 17:35:02 INFO - PID 28612 | RSS: Main: 174612480 17:35:02 INFO - PID 28612 | 17:35:05 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51112/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:06 INFO - PID 28612 | RSS: Main: 179777536 17:35:06 INFO - PID 28612 | 17:35:08 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51112/tests/kraken/driver.html?testName=audio-dft) 17:35:09 INFO - PID 28612 | RSS: Main: 182030336 17:35:09 INFO - PID 28612 | 17:35:12 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51112/tests/kraken/driver.html?testName=audio-fft) 17:35:13 INFO - PID 28612 | RSS: Main: 174485504 17:35:13 INFO - PID 28612 | 17:35:15 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51112/tests/kraken/driver.html?testName=audio-oscillator) 17:35:15 INFO - PID 28612 | RSS: Main: 174903296 17:35:15 INFO - PID 28612 | 17:35:18 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:18 INFO - PID 28612 | RSS: Main: 175337472 17:35:18 INFO - PID 28612 | 17:35:21 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51112/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:22 INFO - PID 28612 | RSS: Main: 176467968 17:35:22 INFO - PID 28612 | 17:35:26 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51112/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:26 INFO - PID 28612 | RSS: Main: 176201728 17:35:26 INFO - PID 28612 | 17:35:29 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51112/tests/kraken/driver.html?testName=json-parse-financial) 17:35:30 INFO - PID 28612 | RSS: Main: 177524736 17:35:30 INFO - PID 28612 | 17:35:31 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:32 INFO - PID 28612 | RSS: Main: 177434624 17:35:32 INFO - PID 28612 | 17:35:34 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:35 INFO - PID 28612 | RSS: Main: 177348608 17:35:35 INFO - PID 28612 | 17:35:37 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:37 INFO - PID 28612 | RSS: Main: 177250304 17:35:37 INFO - PID 28612 | 17:35:40 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:41 INFO - PID 28612 | RSS: Main: 177532928 17:35:41 INFO - PID 28612 | 17:35:44 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:45 INFO - PID 28612 | RSS: Main: 177737728 17:35:45 INFO - PID 28612 | 17:35:46 INFO - PID 28612 | Cycle 1(1): loaded http://localhost:51112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51112/tests/kraken/driver.html?testName=ai-astar) 17:35:47 INFO - PID 28612 | RSS: Main: 179208192 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | __start_tp_report 17:35:47 INFO - PID 28612 | _x_x_mozilla_page_load 17:35:47 INFO - PID 28612 | _x_x_mozilla_page_load_details 17:35:47 INFO - PID 28612 | |i|pagename|runs| 17:35:47 INFO - PID 28612 | |0;ai-astar;99;109;100;108;109;107;115;97;108;114 17:35:47 INFO - PID 28612 | |1;audio-beat-detection;150;120;154;162;120;145;147;122;176;118 17:35:47 INFO - PID 28612 | |2;audio-dft;162;161;167;161;163;162;162;169;170;163 17:35:47 INFO - PID 28612 | |3;audio-fft;75;76;73;177;76;74;80;74;154;91 17:35:47 INFO - PID 28612 | |4;audio-oscillator;83;86;126;80;81;87;123;79;79;136 17:35:47 INFO - PID 28612 | |5;imaging-gaussian-blur;117;117;118;115;113;114;114;114;115;114 17:35:47 INFO - PID 28612 | |6;imaging-darkroom;150;147;149;147;147;147;149;148;149;147 17:35:47 INFO - PID 28612 | |7;imaging-desaturate;100;94;95;94;93;93;93;94;93;99 17:35:47 INFO - PID 28612 | |8;json-parse-financial;52;56;52;61;55;52;53;58;59;52 17:35:47 INFO - PID 28612 | |9;json-stringify-tinderbox;54;55;54;54;55;54;55;57;55;54 17:35:47 INFO - PID 28612 | |10;stanford-crypto-aes;77;81;76;77;76;79;79;82;74;79 17:35:47 INFO - PID 28612 | |11;stanford-crypto-ccm;126;122;127;131;129;127;131;120;119;156 17:35:47 INFO - PID 28612 | |12;stanford-crypto-pbkdf2;177;189;169;179;174;179;175;176;173;171 17:35:47 INFO - PID 28612 | |13;stanford-crypto-sha256-iterative;67;65;68;63;64;66;65;68;67;70 17:35:47 INFO - PID 28612 | __end_tp_report 17:35:47 INFO - PID 28612 | __start_cc_report 17:35:47 INFO - PID 28612 | _x_x_mozilla_cycle_collect,925 17:35:47 INFO - PID 28612 | __end_cc_report 17:35:47 INFO - PID 28612 | __startTimestamp1503707747221__endTimestamp 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | ------- Summary: start ------- 17:35:47 INFO - PID 28612 | Number of tests: 14 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#0] ai-astar Cycles:10 Average:106.60 Median:111.50 stddev:6.10 (5.5%) stddev-sans-first:5.81 17:35:47 INFO - PID 28612 | Values: 99.0 109.0 100.0 108.0 109.0 107.0 115.0 97.0 108.0 114.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:148.50 stddev:20.38 (13.7%) stddev-sans-first:21.38 17:35:47 INFO - PID 28612 | Values: 150.0 120.0 154.0 162.0 120.0 145.0 147.0 122.0 176.0 118.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.37 (2.1%) stddev-sans-first:3.49 17:35:47 INFO - PID 28612 | Values: 162.0 161.0 167.0 161.0 163.0 162.0 162.0 169.0 170.0 163.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.50 stddev:37.91 (50.2%) stddev-sans-first:39.51 17:35:47 INFO - PID 28612 | Values: 75.0 76.0 73.0 177.0 76.0 74.0 80.0 74.0 154.0 91.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:80.50 stddev:22.70 (28.2%) stddev-sans-first:23.59 17:35:47 INFO - PID 28612 | Values: 83.0 86.0 126.0 80.0 81.0 87.0 123.0 79.0 79.0 136.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.66 (1.4%) stddev-sans-first:1.62 17:35:47 INFO - PID 28612 | Values: 117.0 117.0 118.0 115.0 113.0 114.0 114.0 114.0 115.0 114.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.50 stddev:1.15 (0.8%) stddev-sans-first:0.97 17:35:47 INFO - PID 28612 | Values: 150.0 147.0 149.0 147.0 147.0 147.0 149.0 148.0 149.0 147.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.57 (2.7%) stddev-sans-first:1.92 17:35:47 INFO - PID 28612 | Values: 100.0 94.0 95.0 94.0 93.0 93.0 93.0 94.0 93.0 99.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:3.37 (6.1%) stddev-sans-first:3.39 17:35:47 INFO - PID 28612 | Values: 52.0 56.0 52.0 61.0 55.0 52.0 53.0 58.0 59.0 52.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:0.97 17:35:47 INFO - PID 28612 | Values: 54.0 55.0 54.0 54.0 55.0 54.0 55.0 57.0 55.0 54.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:79.00 stddev:2.45 (3.1%) stddev-sans-first:2.57 17:35:47 INFO - PID 28612 | Values: 77.0 81.0 76.0 77.0 76.0 79.0 79.0 82.0 74.0 79.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:128.00 stddev:10.45 (8.2%) stddev-sans-first:11.04 17:35:47 INFO - PID 28612 | Values: 126.0 122.0 127.0 131.0 129.0 127.0 131.0 120.0 119.0 156.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.50 stddev:5.53 (3.1%) stddev-sans-first:5.86 17:35:47 INFO - PID 28612 | Values: 177.0 189.0 169.0 179.0 174.0 179.0 175.0 176.0 173.0 171.0 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.11 (3.2%) stddev-sans-first:2.22 17:35:47 INFO - PID 28612 | Values: 67.0 65.0 68.0 63.0 64.0 66.0 65.0 68.0 67.0 70.0 17:35:47 INFO - PID 28612 | -------- Summary: end -------- 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:35:47 INFO - PID 28612 | 17:35:47 INFO - PID 28612 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:35:47 INFO - TEST-INFO | 28612: exit 0 17:35:48 INFO - TEST-OK | kraken | took 63117ms 17:35:48 INFO - SUITE-END | took 1175s 17:35:48 INFO - Completed test suite (00:19:35) 17:35:48 INFO - javascript benchmark 17:35:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8719.69065640275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.1294406982156, 3326.168457885529, 3335.4329763940127, 3344.5150453184287, 3387.085486918532, 6290.842728931768, 6359.5230357723185, 6384.457321127704, 6411.807645770628, 6480.319566445514, 6264.874702505947, 6348.873022539547, 6360.968195159029, 6461.709223084972, 6516.185476815398, 5871.324797648283, 5881.088431293157, 5903.763849446028, 5934.851628709295, 5953.940460595382, 836.4074977328951, 5605.943940560604, 5762.7406766695385, 5841.0, 5932.822015339547, 5831.358550559435, 5834.504067154276, 5910.379410161936, 5912.1722958785585, 5912.586118971673, 5808.738606762706, 5833.212516310286, 5902.085176797603, 5909.704514774244, 5932.525397968152, 5816.796412125555, 5818.2436283282905, 5876.559258055663, 5893.292804863444, 5914.526837852962, 6161.260648722182, 6360.872782544369, 6387.457066149383, 6432.935670643281, 6443.226812782449, 6726.0, 6731.596104233761, 6764.932350676529, 6824.761133360308, 6843.520953533254, 6909.239983601799, 6917.412019978308, 6940.583564986117, 6945.72217111315, 6955.93044069563, 6334.3032266450655, 6338.778142765027, 6353.30113687494, 6430.196225471816, 6430.93569064308, 6738.764143254963, 6886.965565172142, 6894.172699276019, 6894.551854129466, 6902.585844849325, 6642.202935647753, 6643.601383916884, 6662.56693314933, 6680.23177334603, 6689.464842812563, 6659.567128136656, 6749.628770417674, 6768.83077923046, 6782.898256526156, 6784.050232967388, 6670.83322916931, 6749.6962636681465, 6819.147606549182, 6819.761308354184, 6825.35159159879, 6230.563860529719, 6670.566413183127, 6693.163354580677, 6696.564723293068, 6717.832054198587, 5096.286519887219, 5101.8724531887, 5104.642675012714, 5112.6421150519855, 5119.769610367543, 4530.29780384041, 4571.314302854598, 4632.86101416958, 4646.047560250141, 4650.395448591729, 5997.250343707036, 5997.910031349533, 6056.273247210275, 6059.7273122709585, 6065.727042283108, 6692.86614267712, 6798.66006699663, 6800.8299792504595, 6805.285445028299, 6806.659667016629, 5921.555883308769, 5961.731722072517, 5968.37332080134, 5968.46283834457, 5971.731272092679, 5683.9715801420725, 5725.398833122462, 5733.0, 5752.597318187771, 5758.88482230353, 6567.638779867058, 6593.703283352261, 6643.534952553371, 6668.966655166791, 6687.297833727486, 6673.1992160941, 6791.320867913367, 6806.115205023315, 6809.795706128824, 6909.654517274217, 6543.1821022372205, 6543.476521878333, 6556.573822701509, 6566.409023187936, 6566.671666416755, 6583.835404114744, 6730.8653826924165, 6735.023421603742, 6745.494087943326, 6749.055132281583, 6905.205901321211, 6917.169939607279, 6945.756898508528, 6947.75682851118, 6975.988481670231, 6624.105745724266, 6625.701843417154, 6670.032845237511, 6672.165979252593, 6715.7985260442265, 6467.353264673495, 6617.139771829631, 6623.370779775913, 6703.128593282842, 6724.529282950147, 6519.08732777421, 6521.576097553644, 6576.506761992965, 6601.108850305147, 6618.338166183343, 6688.866222675617, 6699.363560461748, 6727.26000139994, 6749.527533072638, 6776.966115169393, 6334.714937827716, 6398.424141827258, 6450.612963222222, 6537.5750576212395, 6546.18172728409], "value": 6165.352358201948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.9005124359455, 813.0609146435866, 845.1506236232585, 849.6813694864426, 1126.4536699700639, 29843.253918652044, 31308.686913130863, 39541.802290988504, 40590.0, 40644.18711625773, 41544.169116617646, 41946.0, 41950.58049419505, 42131.78934105325, 42182.0, 7416.295451932085, 7602.0, 7746.38028957682, 8052.637631306576, 8062.596870156469, 7878.763637090897, 7969.601519923981, 7980.600969951508, 7981.680732770682, 7988.281054705076, 7934.563599002081, 7983.600819958979, 7990.1610330915, 7991.120976692559, 7994.120646728855, 7948.523088614673, 7950.840983180333, 7958.442908996372, 7993.240642138988, 7995.0805657349565, 7883.290503854623, 7897.407694422941, 7929.603519823986, 7929.762107136795, 7939.682412703485, 37330.253394932224, 37613.0, 37622.0, 37640.62359376399, 37781.0, 3498.073010652179, 3522.18989632386, 3523.6652518010746, 3524.8766293179615, 3526.4533997230214, 30553.69446305553, 30560.84719576388, 30599.235019124477, 30604.693953060407, 30617.38765224683, 5251.474852514756, 5258.55302299305, 5279.815206467755, 5285.497877701612, 5301.0723123453245, 179171.0, 179333.0, 179542.0, 180118.0, 180425.0978745111, 45874.853128671384, 46676.29985550219, 47075.5292447078, 47144.764276179085, 47254.527454725016, 49214.261786073235, 49338.75330623324, 49363.753181233864, 49387.753061235184, 49407.50592494029, 14795.482158124414, 14866.92566537182, 14912.179830109448, 14918.552443426715, 14919.92540037293, 10686.51910664022, 10906.0, 10910.181736369805, 11773.764524709457, 12042.698932526757, 13539.11995720275, 13580.592582222549, 13610.366755989344, 13655.180689158484, 13737.381817818223, 5379.919301210407, 5408.323959505062, 5433.185022246695, 5563.972180139073, 5718.228039214736, 994.194702291132, 1001.4542074569378, 1009.1724785675675, 1021.6322124035341, 1027.8304079826894, 22313.665295020586, 27683.584746228822, 28124.296892577848, 28798.42403151925, 29052.564211536843, 1093.7375029992904, 1094.141099237095, 1101.0640955188187, 1105.8341248812742, 1108.9500972456258, 12321.137520373488, 12495.125341226027, 12532.749345013232, 12549.121561490609, 12648.936755316348, 248287.0, 248983.0, 249577.0, 249908.0, 250413.0, 51878.0, 52388.73805630948, 52514.73742631339, 52648.21027684588, 52649.2102618461, 1405.775075987837, 1424.2451500704642, 1433.519770876768, 1436.2962148547138, 1461.291273732239, 22436.0, 22592.774072259723, 22619.547609048055, 23052.538949220587, 23205.88397058004, 37526.43710344292, 37691.0, 37723.245535088594, 37755.43366849444, 37848.0, 206115.0, 206342.0, 206487.0, 207238.0, 207439.0, 29265.268368290963, 29787.851060744557, 33459.49810752792, 33688.326233474705, 33698.32603347969, 42097.78951105225, 42333.788331058146, 42615.14769704651, 42717.57282427136, 43476.347854782834, 31671.0, 31706.524402134448, 31832.0, 31850.522242165924, 31915.0, 31051.844740776152, 31150.0, 31199.220019499695, 31351.21621959469, 32214.0, 35014.0, 35266.47100293549, 35430.46854297136, 35477.46783798194, 35510.0, 30448.0, 30503.38993220079, 30803.691963080084, 30889.69110308868, 31138.53292200664, 23068.192613259125, 23097.884510578013, 23203.767962320835, 23310.53378932378, 23356.76643233546], "value": 17013.497807961132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6258538072182, 562.7833284185588, 565.9151127330903, 575.8790653962668, 586.6685322792622, 22207.1117155314, 22519.324420267396, 23306.4173395665, 23308.5338293234, 23324.183653572127, 22639.0, 24435.266941991726, 24484.755152448513, 24575.508489830194, 24620.26139215822, 7121.928780712191, 7306.415486761046, 7308.890366644505, 7309.451791115661, 7310.926890731104, 6379.553431259814, 7079.964600176992, 7081.150261968545, 7093.858122837541, 7293.817654558652, 7030.121234845645, 7048.18945821232, 7048.964755176243, 7050.788476345718, 7054.964725176367, 7043.190033146177, 7057.89413158803, 7058.329458701415, 7067.646617669147, 7071.186813516409, 6921.411680007205, 6922.134733158356, 6932.341427564424, 6935.237123916365, 6941.0, 30284.394312113633, 31082.22294442657, 31569.36861262762, 31698.0, 31705.682943170505, 2102.7266455360705, 2128.1487405037956, 2136.327056977047, 2138.3691810915816, 2138.5295235048266, 20328.593428131353, 21108.522403431765, 21138.577228455346, 21141.788582114135, 21146.788532114635, 2486.925392238236, 2490.2778194323623, 2562.5515534781525, 2583.870806459688, 2585.4312051348675, 138762.30618846943, 142775.0, 143188.0, 143394.0, 143401.0, 19105.21160266293, 21029.579408411748, 21299.78700213009, 21418.464538386666, 21466.892665536572, 41930.37104443436, 42125.0, 42150.578494214664, 42226.577734222265, 42257.78871105686, 11082.390468524309, 11115.944420277847, 11127.777444451227, 11255.324680519032, 11391.772164556662, 8230.300424463869, 9212.170904618617, 9236.261099112055, 9305.720828375159, 9334.813303733887, 9169.449833010041, 10887.891121088687, 10896.346219226712, 11289.266197697123, 11526.308421494738, 3668.596454390015, 3835.6356146166067, 4111.8972025699595, 4224.177952606579, 4292.5707429257445, 913.1462082952461, 947.6398968392105, 970.9951450242703, 972.8151651186251, 983.6655537117272, 19088.71366929497, 19771.802281977285, 23092.884535577214, 23250.65124023141, 23501.17745878886, 981.1169947047714, 1026.4354604967386, 1031.3141760729031, 1034.1364960258268, 1037.984430233547, 11032.44837758109, 11315.886841131483, 11353.659390218307, 11363.545458181745, 11479.426028698532, 499450.0, 515929.0, 516156.0, 532585.0, 535693.0, 120186.39906800585, 122812.38593807153, 122816.38591806983, 125085.37457312655, 125535.37232313963, 1204.1275963081325, 1214.0409076829205, 1215.9756804863853, 1236.8577613574373, 1241.0381953985734, 18492.630147397245, 18510.722339164655, 18860.151293192113, 21131.366059018255, 22297.77702222957, 58739.0, 59290.0, 60089.09866351921, 61099.38900610937, 61908.0, 67962.66018669875, 68467.0, 68811.0, 68886.31113689, 68898.65550672215, 14385.928070359581, 14862.0, 14866.554003379915, 14944.775828362366, 15092.773608395662, 23152.305430837103, 23362.415939600967, 23610.0, 23693.763062369155, 23781.167659131846, 18376.356827510972, 18528.44414667562, 18546.0, 18685.15916783721, 18700.345487908402, 15978.760318595463, 16276.267567959707, 16300.184990750653, 16712.66574668524, 17366.305347785947, 16660.0, 18981.905090474458, 19456.221751129797, 19555.70666439976, 19605.50986225356, 14730.189839558927, 14795.926020369829, 14825.110493370432, 14827.0, 14896.478623248135, 18200.726989095438, 18559.628807424047, 18651.160697768904, 18658.067096645384, 18725.0], "value": 12890.088443254686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.7461594988974, 1354.3634491788855, 1374.9037567370287, 1376.9655758606027, 1380.9516666916657, 14498.0, 14660.560183194495, 15355.155466449341, 15355.385784568633, 15363.385464581417, 15709.0, 15881.841181588181, 15935.681286374265, 15955.042697438163, 15955.282012309444, 2774.4728501584686, 2812.2406950123454, 2815.6761972373133, 2823.9294017649518, 2826.943461130776, 2698.8380697158136, 2719.7008329083783, 2759.503289407916, 2761.5443451830524, 2763.1848604661573, 2699.217227004176, 2732.412531305769, 2794.2874566985392, 2794.4271424357958, 2796.748292653661, 2636.182783337162, 2667.0, 2667.8932842686268, 2668.679758429001, 2668.83986960781, 2632.2234940692542, 2640.93397665058, 2642.471505698868, 2647.9205623831317, 2656.8671566421604, 14418.711625767426, 14758.335874885548, 14759.852401475955, 14801.851981480155, 14813.629659258497, 7713.6914523419, 7968.0, 8002.559859207741, 8005.6797728090805, 8009.9199008009755, 5177.352830896138, 5397.082495975694, 5495.53287970523, 5503.3120859892515, 5523.558115350803, 1899.629572233415, 1946.4939115829845, 1955.7555305586802, 1998.99000504998, 2005.5587770690424, 24692.629610555858, 24939.251822445356, 24945.750542494523, 24952.251432456873, 24958.750412496007, 6469.838254043687, 6490.188726409199, 6586.538942274091, 6651.268360480343, 6713.798586042427, 15864.206789660471, 15873.444429444913, 15877.920610396874, 15889.046657200604, 15897.920510397606, 7292.088488938883, 7444.292792184734, 7449.515781474187, 7458.291462311072, 7461.440391970624, 5786.0, 5805.912911306334, 5961.821145365646, 6252.280987686474, 7285.635718214068, 5077.162268225775, 5207.427183009866, 5216.60875434344, 5246.396664383568, 5300.621838322064, 1503.7368460519365, 1536.9077855328717, 1537.6155961009747, 1547.6440418703762, 1551.0538571471393, 894.0969620683027, 908.6229214875884, 930.7952250504878, 938.7746940734174, 942.6323733743845, 7846.725364612325, 7858.882116768253, 7967.203279672102, 7972.521648701097, 9092.136247056518, 982.3761911186448, 987.2496902354262, 992.6228033347281, 993.450217660452, 1013.1843865688045, 5193.2989046479, 5485.177223416519, 5543.861403464865, 5560.304961879765, 5664.348599911063, 19867.205311787657, 20144.294949676692, 20586.691199632016, 20638.58722825535, 20674.173033078507, 20060.69908951367, 20134.69797953032, 20243.595128097357, 20271.898640506704, 20279.594408111756, 10223.386596804066, 11276.267042642367, 11357.091432685365, 11370.545178192946, 11384.943075284737, 8527.786805329917, 8756.299496040174, 8839.779005524913, 8995.910040899507, 9315.767105822408, 17303.221355039306, 17873.463796086136, 17912.0, 18251.269949201884, 18314.45056648303, 17922.372716954844, 18268.72596911074, 18340.17469213862, 18356.632867342847, 18581.0, 13356.933215333862, 13576.1854288743, 13653.453861845415, 14041.859581404464, 14159.433622654979, 13726.794098088338, 13893.652658683613, 13894.305284735925, 13894.652633684238, 13902.23537705436, 10877.966593173636, 10965.945170274417, 11024.944875275572, 11027.724306892393, 11169.050630696482, 10570.41862697559, 10720.571177153139, 11835.64493065175, 11903.10726695484, 11938.0, 10127.0, 10339.689809305733, 10345.948270258601, 10345.948270258901, 10354.689359319233, 7540.245975402416, 7593.696252150073, 7673.8465230693955, 7687.2697093776005, 7717.382609391123, 7234.891476627749, 7275.199728030018, 7282.96358518204, 7289.890651640124, 7349.228331025165], "value": 6658.179068670138, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.99749001254986, 506.5213373362173, 520.6459607466923, 525.1964494323684, 531.2509361799861, 6344.65247858292, 6412.903806442907, 6441.777586732575, 6445.323241059691, 6446.45205157561, 6296.0, 6326.968365158168, 6346.968265158679, 6379.341371243487, 6396.616203027822, 5170.9741451292875, 5277.604179686519, 5290.7354632268425, 5292.100342941709, 5314.388845282784, 5290.470952904717, 5328.307320048389, 5332.786688532454, 5364.865878353034, 5403.1089118808295, 5312.92030619541, 5319.228711836781, 5354.544863686591, 5368.8389348319615, 5381.488758567949, 5281.313429254211, 5312.548433383167, 5336.932613477281, 5360.571154307646, 5363.758630861621, 4908.950910490885, 4924.113659541281, 4976.4525902150735, 4984.102861484931, 5013.74656335916, 6295.433410992987, 6378.904316435211, 6440.51696122788, 6441.194850643669, 6476.481881449473, 6073.878522429571, 6120.234970628671, 6158.3841615838055, 6168.784092556783, 6192.566520343577, 6827.863442731167, 6834.6582670866255, 6856.211535673411, 6875.518713690044, 6885.380315771555, 5340.0, 5358.973205133989, 5383.0, 5408.621396502246, 5429.701366424845, 6715.3620406061345, 6763.526553141282, 6993.545419547713, 6993.545419547713, 7087.468439867031, 5504.119340905436, 5517.751701173457, 5544.16837474374, 5568.777248909998, 5590.720463976785, 5615.410381909923, 5619.8876022480135, 5623.381428042912, 5630.296212973379, 5652.236948012048, 6032.819015429544, 6049.425304596057, 6053.818385448443, 6079.787207447718, 6138.907916381258, 6838.384545390939, 6840.845133782843, 6882.346177113166, 6893.965530172417, 6916.0, 1979.8119178678003, 1994.1126198841666, 2000.759908810952, 2006.2946495478727, 2006.6287736768745, 1393.2197969137314, 1434.8493408192198, 1436.978445323321, 1467.229704405196, 1476.0848274070145, 5907.822765317047, 5917.911231331534, 5957.79147729836, 5974.133750606225, 6006.819795406145, 6748.831279218059, 6767.695453704595, 6799.218089919723, 6805.353491418307, 6870.587764734132, 5946.0675280534, 5971.164037034819, 5977.6114552553945, 5984.551158663117, 5993.61041532299, 3620.873269435557, 3632.328019316435, 3650.634936506328, 3661.761985470936, 3705.8517659293866, 6623.536352455282, 6707.262201157869, 6708.530402871752, 6747.426468750113, 6758.966205169041, 6871.4502839772695, 6940.895886561706, 7051.92948070523, 7128.857422851514, 7164.928350716426, 6620.0, 6633.635150066792, 6656.167979002625, 6659.334066593399, 6696.7656132035145, 6711.228208756055, 6726.8654626908165, 6781.084553585203, 6809.8638027238185, 6874.793756187322, 6797.762078327235, 6812.0, 6818.659067046727, 6853.520253582401, 6981.441484681315, 6552.460171859514, 6607.471402287902, 6641.269460359454, 6673.632950187592, 6683.699233534599, 5548.306461692288, 5554.500094991308, 5579.163125531203, 5580.35825880029, 5612.382637909908, 6565.967170164118, 6610.933890661032, 6655.434288085373, 6780.321967803377, 6952.652367381712, 6502.252240992158, 6588.562231974201, 6633.2371777246235, 6654.334566543307, 6656.800295991128, 6494.155759751202, 6545.705443254969, 6637.867242655217, 6658.933410666025, 6676.298988606127, 6481.773137940149, 6551.934480655133, 6561.3438656134, 6619.505810177638, 6722.226943901514, 6693.230278518033, 6716.966415167893, 6730.394264516217, 6736.494762892705, 6759.391654751096, 6525.282218956006, 6533.509986750918, 6557.344265573404, 6557.508186885907, 6564.770233042012], "value": 5311.481304905247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.8776571280022, 881.8500854854675, 896.0815164456434, 897.5063714956772, 901.8286525560143, 18434.63130737386, 19286.51783705408, 19297.90351048243, 19367.322143724974, 21950.670739938872, 19560.0, 19997.0, 20203.090860911256, 20220.898895505503, 20263.696044559343, 921.7465197070826, 922.2253307221915, 928.8467402878517, 929.330881765128, 929.4005366538579, 942.6842007927353, 943.8772959515253, 943.8772959515253, 945.3902233059672, 951.0917074194163, 951.8001219743862, 987.6395115782724, 990.8761404824397, 992.3748038735587, 995.7809281957993, 982.4891056650538, 984.2716389871515, 984.3896783993933, 984.7095106943398, 985.4038306824375, 711.7010855440727, 712.2130046298817, 712.3482013957223, 713.062323045199, 719.586237913202, 18174.382300425896, 18507.907460462746, 18610.90694546532, 18707.53231169218, 18709.345172918882, 21172.89413552938, 21353.679694804592, 21731.456713582287, 21770.89114554417, 21792.891035544722, 16331.591710207222, 16437.753433698505, 16465.094419806905, 16468.42360517376, 17479.21343539531, 3803.2013277211818, 3838.2899163654815, 3838.846446142151, 3841.2701586698436, 3849.2878817418587, 116542.0, 125844.0, 126232.0, 127732.36133819271, 130000.0, 16540.338386464646, 16591.170441477876, 16972.575685607957, 17030.659386812193, 17057.829421705625, 28481.430371392456, 30139.397212055635, 30150.396992060036, 30173.547396789065, 30174.245643859078, 7714.961425192951, 8061.637226324712, 8794.208521232991, 8899.866502002475, 9081.54592270384, 4327.0480494291205, 4437.068215674744, 4446.3108218226225, 4458.598726114666, 4460.553944605514, 4952.232403977389, 5023.673461225008, 5071.847844564669, 5092.567131793839, 5095.159298715745, 1085.8208395614793, 1099.8460215569826, 1112.232559533919, 1113.4098927568402, 1116.1015382616908, 685.0819901332139, 702.8032150997728, 711.0969069282087, 715.3561794384991, 718.6299055986171, 11767.941160294315, 11892.037544348146, 11930.940345298219, 11946.522139114339, 12561.748765024648, 693.4036728413561, 710.5345998370972, 711.0969069282087, 711.3704371631144, 716.8530451257479, 6109.786157484556, 6124.816255512342, 6320.512436170278, 6397.872042559123, 6508.284088750233, 114111.42944285226, 114399.42800285945, 114836.0, 116483.41758291154, 117392.0, 91699.0, 92396.0, 93737.531312343, 95399.0, 96173.0, 86985.56507217423, 88784.5560772192, 90037.54981225052, 91191.0, 91730.54134729283, 11817.05018671944, 12782.68043298925, 13002.154859934075, 13067.215967042008, 13102.213867168, 40979.0, 41429.378559322235, 41508.0, 41995.58004419917, 43670.344944825214, 72483.63758181386, 72653.636731816, 73654.63172684102, 74031.25968740458, 75168.0, 18230.908845455688, 18920.148593313057, 18965.71551426702, 19024.904875476088, 19035.0, 17110.572235694206, 17501.21244544024, 20274.364668147053, 20941.685874712195, 21438.892805535874, 18470.907645461688, 18575.44273671792, 18680.626387471904, 18926.621467570298, 19500.0, 17841.0, 17873.463796086136, 19177.232910683975, 19471.22115115436, 19644.312449064215, 16111.355545778037, 16450.259738311564, 17969.640607188045, 17990.280388784304, 18947.621047579247, 13968.301584920917, 14053.0, 14098.718025639635, 14468.565943021726, 14758.409663613334, 13977.650558736113, 14213.0, 14224.217668027944, 14284.07153535017, 14287.57137285883], "value": 9191.848837449574, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 100.0, 108.0, 109.0, 107.0, 115.0, 97.0, 108.0, 114.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 154.0, 162.0, 120.0, 145.0, 147.0, 122.0, 176.0, 118.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 167.0, 161.0, 163.0, 162.0, 162.0, 169.0, 170.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 177.0, 76.0, 74.0, 80.0, 74.0, 154.0, 91.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 126.0, 80.0, 81.0, 87.0, 123.0, 79.0, 79.0, 136.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 115.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 149.0, 147.0, 147.0, 147.0, 149.0, 148.0, 149.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 95.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 99.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 52.0, 61.0, 55.0, 52.0, 53.0, 58.0, 59.0, 52.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0, 57.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 77.0, 76.0, 79.0, 79.0, 82.0, 74.0, 79.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 127.0, 131.0, 129.0, 127.0, 131.0, 120.0, 119.0, 156.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 189.0, 169.0, 179.0, 174.0, 179.0, 175.0, 176.0, 173.0, 171.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 68.0, 63.0, 64.0, 66.0, 65.0, 68.0, 67.0, 70.0], "value": 66.3, "unit": "score"}]}]} 17:35:48 INFO - Return code: 0 17:35:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:35:48 INFO - # TBPL SUCCESS # 17:35:48 INFO - Running post-action listener: _package_coverage_data 17:35:48 INFO - Running post-action listener: _resource_record_post_action 17:35:48 INFO - [mozharness: 2017-08-26 00:35:48.518097Z] Finished run-tests step (success) 17:35:48 INFO - Running post-run listener: _resource_record_post_run 17:35:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 426057728; Read time: 216; Write time: 375648 17:35:48 INFO - TinderboxPrint: CPU usage
13.2% 17:35:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 17:35:48 INFO - TinderboxPrint: I/O write bytes / time
426,057,728 / 375,648 17:35:48 INFO - TinderboxPrint: CPU idle
8,264.6 (86.8%) 17:35:48 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 17:35:48 INFO - TinderboxPrint: Swap in / out
0 / 0 17:35:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105254912; Read time: 0; Write time: 120552 17:35:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:35:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320802816; Read time: 208; Write time: 255096 17:35:49 INFO - Running post-run listener: _upload_blobber_files 17:35:49 INFO - Blob upload gear active. 17:35:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:49 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 17:35:49 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'] 17:35:49 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 17:35:49 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:50 INFO - (blobuploader) - INFO - Done attempting. 17:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:51 INFO - (blobuploader) - INFO - Done attempting. 17:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:35:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:55 INFO - (blobuploader) - INFO - Done attempting. 17:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:56 INFO - (blobuploader) - INFO - Done attempting. 17:35:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:56 INFO - Return code: 0 17:35:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe3895b966f4431615d73bdea75a3114bf5ec67e933e9078397d0b848aca5194f6c930592889c9a52dedeb81cc374eaf71f985e727607acdfb3749ad962c9c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54281ec438d0da0793e8eb83e6c52819b87a92c2b14f93326e7bf63d7d4bc2c99b95c5f9881349ee3cd53626b647e02cfab6c9d9b30c664e8f0e5ff96108cca6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd4d56e9cc6073ebcd5c78672289d6d87c3f7139a4c64a79a9faeb429c2162634a9c35cad8cc107a72a4ccf5da216a2231f302d61b2837d6efb813c7e4ef6efd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719d58b750081ee3f99cfbbabdeb22f180947417f00626f2cc5c444c03d588f9f3da524edd5fd6a21e4883dfc36d474109c389484ca23ccd388610f322d535c9"} 17:35:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:56 INFO - Contents: 17:35:56 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe3895b966f4431615d73bdea75a3114bf5ec67e933e9078397d0b848aca5194f6c930592889c9a52dedeb81cc374eaf71f985e727607acdfb3749ad962c9c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54281ec438d0da0793e8eb83e6c52819b87a92c2b14f93326e7bf63d7d4bc2c99b95c5f9881349ee3cd53626b647e02cfab6c9d9b30c664e8f0e5ff96108cca6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd4d56e9cc6073ebcd5c78672289d6d87c3f7139a4c64a79a9faeb429c2162634a9c35cad8cc107a72a4ccf5da216a2231f302d61b2837d6efb813c7e4ef6efd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719d58b750081ee3f99cfbbabdeb22f180947417f00626f2cc5c444c03d588f9f3da524edd5fd6a21e4883dfc36d474109c389484ca23ccd388610f322d535c9"} 17:35:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:56 INFO - Copying logs to upload dir... 17:35:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.938812 ========= master_lag: 0.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-25 17:35:56.166152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 17:35:56.170541) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500 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/2fe3895b966f4431615d73bdea75a3114bf5ec67e933e9078397d0b848aca5194f6c930592889c9a52dedeb81cc374eaf71f985e727607acdfb3749ad962c9c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54281ec438d0da0793e8eb83e6c52819b87a92c2b14f93326e7bf63d7d4bc2c99b95c5f9881349ee3cd53626b647e02cfab6c9d9b30c664e8f0e5ff96108cca6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd4d56e9cc6073ebcd5c78672289d6d87c3f7139a4c64a79a9faeb429c2162634a9c35cad8cc107a72a4ccf5da216a2231f302d61b2837d6efb813c7e4ef6efd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719d58b750081ee3f99cfbbabdeb22f180947417f00626f2cc5c444c03d588f9f3da524edd5fd6a21e4883dfc36d474109c389484ca23ccd388610f322d535c9"} build_url:https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/CvxZbX7nQM278U8qCtb6OQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fe3895b966f4431615d73bdea75a3114bf5ec67e933e9078397d0b848aca5194f6c930592889c9a52dedeb81cc374eaf71f985e727607acdfb3749ad962c9c4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54281ec438d0da0793e8eb83e6c52819b87a92c2b14f93326e7bf63d7d4bc2c99b95c5f9881349ee3cd53626b647e02cfab6c9d9b30c664e8f0e5ff96108cca6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd4d56e9cc6073ebcd5c78672289d6d87c3f7139a4c64a79a9faeb429c2162634a9c35cad8cc107a72a4ccf5da216a2231f302d61b2837d6efb813c7e4ef6efd", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719d58b750081ee3f99cfbbabdeb22f180947417f00626f2cc5c444c03d588f9f3da524edd5fd6a21e4883dfc36d474109c389484ca23ccd388610f322d535c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 17:35:56.199994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:35:56.200336) ========= 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=fcadb68e09dcf59683000ff6000001dc-1503706501.53416-1999028500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 17:35:56.280983) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 17:35:56.284310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 17:35:56.284603) ========= ========= Total master_lag: 0.95 =========