builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-081 starttime: 1503673103.25 results: success (0) revision: 56188620cce00b19700fbb8efaafea65e6ca8c61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.253914) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.254359) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.254651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.270909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.271238) ========= 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=483e410453545d07cca6935c000001ab-1503668027.538621-853868537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-25 07:58:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 77.1M=0s 2017-08-25 07:58:23 (77.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092471 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.382195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.382503) ========= 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=483e410453545d07cca6935c000001ab-1503668027.538621-853868537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015312 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:23.433730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 07:58:23.434058) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 56188620cce00b19700fbb8efaafea65e6ca8c61 --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 56188620cce00b19700fbb8efaafea65e6ca8c61 --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=483e410453545d07cca6935c000001ab-1503668027.538621-853868537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-25 07:58:23,468 truncating revision to first 12 chars 2017-08-25 07:58:23,468 Setting DEBUG logging. 2017-08-25 07:58:23,468 attempt 1/10 2017-08-25 07:58:23,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/56188620cce0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-25 07:58:24,345 unpacking tar archive at: mozilla-central-56188620cce0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.212685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-25 07:58:24.663149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:24.663422) ========= script_repo_revision: 56188620cce00b19700fbb8efaafea65e6ca8c61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:24.663804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:24.664065) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-25 07:58:24.675700) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-25 07:58:24.676046) ========= /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=483e410453545d07cca6935c000001ab-1503668027.538621-853868537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:58:24 INFO - MultiFileLogger online at 20170825 07:58:24 in /builds/slave/test 07:58:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:58:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:58:24 INFO - {'append_to_log': False, 07:58:24 INFO - 'base_work_dir': '/builds/slave/test', 07:58:24 INFO - 'blob_upload_branch': 'Firefox', 07:58:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:58:24 INFO - 'branch': 'Firefox', 07:58:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:24 INFO - 'code_coverage': False, 07:58:24 INFO - 'config_files': ('talos/linux_config.py',), 07:58:24 INFO - 'default_actions': ('clobber', 07:58:24 INFO - 'read-buildbot-config', 07:58:24 INFO - 'download-and-extract', 07:58:24 INFO - 'populate-webroot', 07:58:24 INFO - 'create-virtualenv', 07:58:24 INFO - 'install', 07:58:24 INFO - 'setup-mitmproxy', 07:58:24 INFO - 'run-tests'), 07:58:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:24 INFO - 'disable_ccov_upload': False, 07:58:24 INFO - 'download_minidump_stackwalk': True, 07:58:24 INFO - 'download_symbols': 'ondemand', 07:58:24 INFO - 'enable_stylo': False, 07:58:24 INFO - 'enable_webrender': False, 07:58:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:58:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:24 INFO - 'gecko_profile': False, 07:58:24 INFO - 'gecko_profile_interval': 0, 07:58:24 INFO - 'installer_path': 'installer.exe', 07:58:24 INFO - 'log_level': 'info', 07:58:24 INFO - 'log_name': 'talos', 07:58:24 INFO - 'log_to_console': True, 07:58:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:58:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:58:24 INFO - 'opt_config_files': (), 07:58:24 INFO - 'pip_index': False, 07:58:24 INFO - 'suite': 'dromaeojs-e10s', 07:58:24 INFO - 'system_bits': '32', 07:58:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:24 INFO - 'title': 'talos-linux64-ix-081', 07:58:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:24 INFO - 'use_talos_json': True, 07:58:24 INFO - 'verify': 'False', 07:58:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:58:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:24 INFO - 'work_dir': 'build'} 07:58:24 INFO - [mozharness: 2017-08-25 14:58:24.854302Z] Running clobber step. 07:58:24 INFO - Running pre-action listener: _resource_record_pre_action 07:58:24 INFO - Running main action method: clobber 07:58:24 INFO - rmtree: /builds/slave/test/build 07:58:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:58:26 INFO - Running post-action listener: _resource_record_post_action 07:58:26 INFO - [mozharness: 2017-08-25 14:58:26.378542Z] Finished clobber step (success) 07:58:26 INFO - [mozharness: 2017-08-25 14:58:26.378639Z] Running read-buildbot-config step. 07:58:26 INFO - Running pre-action listener: _resource_record_pre_action 07:58:26 INFO - Running main action method: read_buildbot_config 07:58:26 INFO - Using buildbot properties: 07:58:26 INFO - { 07:58:26 INFO - "project": "", 07:58:26 INFO - "product": "firefox", 07:58:26 INFO - "who": "ryanvm@gmail.com", 07:58:26 INFO - "installer_path": "public/build/target.tar.bz2", 07:58:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 07:58:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:58:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 07:58:26 INFO - "stage_platform": "linux64-stylosequential", 07:58:26 INFO - "basedir": "/builds/slave/test", 07:58:26 INFO - "buildnumber": 210, 07:58:26 INFO - "platform": "ubuntu64_hw_styloseq", 07:58:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:58:26 INFO - "slavebuilddir": "test", 07:58:26 INFO - "taskId": "A8GLnkAkTyeAFZZMcmFDWg", 07:58:26 INFO - "branch": "mozilla-central", 07:58:26 INFO - "script_repo_revision": "production", 07:58:26 INFO - "revision": "56188620cce00b19700fbb8efaafea65e6ca8c61", 07:58:26 INFO - "slavename": "talos-linux64-ix-081", 07:58:26 INFO - "repo_path": "mozilla-central" 07:58:26 INFO - } 07:58:26 INFO - Finding installer, test and symbols from parent task. 07:58:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8GLnkAkTyeAFZZMcmFDWg'}, attempt #1 07:58:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8GLnkAkTyeAFZZMcmFDWg'}, attempt #1 07:58:27 INFO - Task dependencies: Ehja7yuaStWOcBSW8mDwsA 07:58:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA'}, attempt #1 07:58:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2 07:58:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.test_packages.json 07:58:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.crashreporter-symbols.zip 07:58:27 INFO - Running post-action listener: _resource_record_post_action 07:58:27 INFO - [mozharness: 2017-08-25 14:58:27.759608Z] Finished read-buildbot-config step (success) 07:58:27 INFO - [mozharness: 2017-08-25 14:58:27.759824Z] Running download-and-extract step. 07:58:27 INFO - Running pre-action listener: _resource_record_pre_action 07:58:27 INFO - Running main action method: download_and_extract 07:58:27 INFO - mkdir: /builds/slave/test/build/tests 07:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:27 INFO - trying https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.test_packages.json 07:58:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:58:28 INFO - Downloaded 989 bytes. 07:58:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:58:28 INFO - Using the following test package requirements: 07:58:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:58:28 INFO - u'common': [u'target.common.tests.zip'], 07:58:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:58:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:58:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:58:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:58:28 INFO - u'mozbase': [u'target.common.tests.zip'], 07:58:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:58:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:58:28 INFO - u'web-platform': [u'target.common.tests.zip', 07:58:28 INFO - u'target.web-platform.tests.tar.gz'], 07:58:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:58:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:58:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.common.tests.zip 07:58:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:58:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.common.tests.zip into memory 07:58:29 INFO - Content-Length response header: 54979231 07:58:29 INFO - Bytes received: 54979231 07:58:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:58:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.common.tests.zip 07:58:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:58:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.common.tests.zip into memory 07:58:41 INFO - Content-Length response header: 54979231 07:58:41 INFO - Bytes received: 54979231 07:58:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.talos.tests.zip 07:58:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:58:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.talos.tests.zip into memory 07:58:54 INFO - Content-Length response header: 14496611 07:58:54 INFO - Bytes received: 14496611 07:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:54 INFO - trying https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2 07:58:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:58:56 INFO - Downloaded 61137109 bytes. 07:58:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2 07:58:56 INFO - mkdir: /builds/slave/test/properties 07:58:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:56 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:56 INFO - Contents: 07:58:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2 07:58:56 INFO - Running post-action listener: _resource_record_post_action 07:58:56 INFO - Running post-action listener: find_tests_for_verification 07:58:56 INFO - Running post-action listener: set_extra_try_arguments 07:58:56 INFO - [mozharness: 2017-08-25 14:58:56.101113Z] Finished download-and-extract step (success) 07:58:56 INFO - [mozharness: 2017-08-25 14:58:56.101211Z] Running populate-webroot step. 07:58:56 INFO - Running pre-action listener: _resource_record_pre_action 07:58:56 INFO - Running main action method: populate_webroot 07:58:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:56 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:56 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:56 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'tests': ['damp', 'tps']}, 07:58:56 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['damp', 'tps']}, 07:58:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:58:56 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:58:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:58:56 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:58:56 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:56 INFO - 'ts_paint', 07:58:56 INFO - 'tpaint', 07:58:56 INFO - 'sessionrestore', 07:58:56 INFO - 'sessionrestore_many_windows', 07:58:56 INFO - 'sessionrestore_no_auto_restore', 07:58:56 INFO - 'tabpaint']}, 07:58:56 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['a11yr', 07:58:56 INFO - 'ts_paint', 07:58:56 INFO - 'tpaint', 07:58:56 INFO - 'sessionrestore', 07:58:56 INFO - 'sessionrestore_many_windows', 07:58:56 INFO - 'sessionrestore_no_auto_restore', 07:58:56 INFO - 'tabpaint']}, 07:58:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:58:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:58:56 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['bloom_basic_singleton']}, 07:58:56 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['bloom_basic']}, 07:58:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:56 INFO - 'tsvgr_opacity', 07:58:56 INFO - 'tart', 07:58:56 INFO - 'tscrollx', 07:58:56 INFO - 'tsvg_static']}, 07:58:56 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['tsvgx', 07:58:56 INFO - 'tsvgr_opacity', 07:58:56 INFO - 'tart', 07:58:56 INFO - 'tscrollx', 07:58:56 INFO - 'tsvg_static']}, 07:58:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:58:56 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'talos_options': ['--stylo'], 07:58:56 INFO - 'tests': ['tp5o']}, 07:58:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:58:56 INFO - 'talos_options': ['--mitmproxy', 07:58:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:58:56 INFO - '--firstNonBlankPaint'], 07:58:56 INFO - 'tests': ['tp6_google', 07:58:56 INFO - 'tp6_youtube', 07:58:56 INFO - 'tp6_amazon', 07:58:56 INFO - 'tp6_facebook']}, 07:58:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:58:56 INFO - 'talos_options': ['--stylo', 07:58:56 INFO - '--mitmproxy', 07:58:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:58:56 INFO - '--firstNonBlankPaint'], 07:58:56 INFO - 'tests': ['tp6_google', 07:58:56 INFO - 'tp6_youtube', 07:58:56 INFO - 'tp6_amazon', 07:58:56 INFO - 'tp6_facebook']}, 07:58:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:58:56 INFO - 'talos_options': ['--stylo', 07:58:56 INFO - '--stylo-threads=1', 07:58:56 INFO - '--mitmproxy', 07:58:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:58:56 INFO - '--firstNonBlankPaint'], 07:58:56 INFO - 'tests': ['tp6_google', 07:58:56 INFO - 'tp6_youtube', 07:58:56 INFO - 'tp6_amazon', 07:58:56 INFO - 'tp6_facebook']}, 07:58:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'talos_options': ['--xperf_path', 07:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:56 INFO - 'tests': ['tp5n']}, 07:58:56 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 07:58:56 INFO - 'talos_options': ['--stylo', 07:58:56 INFO - '--xperf_path', 07:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:56 INFO - 'tests': ['tp5n']}}} 07:58:56 INFO - Running post-action listener: _resource_record_post_action 07:58:56 INFO - [mozharness: 2017-08-25 14:58:56.115382Z] Finished populate-webroot step (success) 07:58:56 INFO - [mozharness: 2017-08-25 14:58:56.115471Z] Running create-virtualenv step. 07:58:56 INFO - Running pre-action listener: _resource_record_pre_action 07:58:56 INFO - Running main action method: create_virtualenv 07:58:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:56 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:58:56 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:58:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:58:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:56 INFO - Installing pip...............done. 07:58:57 INFO - Return code: 0 07:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:58:57 INFO - Reading from file tmpfile_stdout 07:58:57 INFO - Output received: 07:58:57 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:58:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:58:57 INFO - Using env: {'DISPLAY': ':0', 07:58:57 INFO - 'HOME': '/home/cltbld', 07:58:57 INFO - 'LANG': 'en_US.UTF-8', 07:58:57 INFO - 'LANGUAGE': 'en_US:en', 07:58:57 INFO - 'LOGNAME': 'cltbld', 07:58:57 INFO - 'MAIL': '/var/mail/cltbld', 07:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:57 INFO - 'MOZ_NO_REMOTE': '1', 07:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:57 INFO - 'NO_EM_RESTART': '1', 07:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:57 INFO - 'PWD': '/builds/slave/test', 07:58:57 INFO - 'SHELL': '/bin/bash', 07:58:57 INFO - 'SHLVL': '1', 07:58:57 INFO - 'TERM': 'linux', 07:58:57 INFO - 'TMOUT': '86400', 07:58:57 INFO - 'USER': 'cltbld', 07:58:57 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:57 INFO - '_': '/tools/buildbot/bin/python'} 07:58:58 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:58:58 INFO - Downloading/unpacking pip>=1.5 07:58:58 INFO - Running setup.py egg_info for package pip 07:58:58 INFO - warning: no files found matching 'pip/cacert.pem' 07:58:58 INFO - warning: no files found matching '*.html' under directory 'docs' 07:58:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:58:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:58:58 INFO - Installing collected packages: pip 07:58:58 INFO - Found existing installation: pip 1.1 07:58:58 INFO - Uninstalling pip: 07:58:58 INFO - Successfully uninstalled pip 07:58:58 INFO - Running setup.py install for pip 07:58:58 INFO - warning: no files found matching 'pip/cacert.pem' 07:58:58 INFO - warning: no files found matching '*.html' under directory 'docs' 07:58:58 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:58:58 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:58:58 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:58:58 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:58:58 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:58:58 INFO - Successfully installed pip 07:58:58 INFO - Cleaning up... 07:58:58 INFO - Return code: 0 07:58:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:58:58 INFO - Using env: {'DISPLAY': ':0', 07:58:58 INFO - 'HOME': '/home/cltbld', 07:58:58 INFO - 'LANG': 'en_US.UTF-8', 07:58:58 INFO - 'LANGUAGE': 'en_US:en', 07:58:58 INFO - 'LOGNAME': 'cltbld', 07:58:58 INFO - 'MAIL': '/var/mail/cltbld', 07:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:58 INFO - 'MOZ_NO_REMOTE': '1', 07:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:58 INFO - 'NO_EM_RESTART': '1', 07:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:58 INFO - 'PWD': '/builds/slave/test', 07:58:58 INFO - 'SHELL': '/bin/bash', 07:58:58 INFO - 'SHLVL': '1', 07:58:58 INFO - 'TERM': 'linux', 07:58:58 INFO - 'TMOUT': '86400', 07:58:58 INFO - 'USER': 'cltbld', 07:58:58 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:58 INFO - '_': '/tools/buildbot/bin/python'} 07:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:58 INFO - Downloading/unpacking psutil>=3.1.1 07:58:58 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 07:58:58 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 07:58:58 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 07:58:58 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 07:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:59 INFO - Installing collected packages: psutil 07:58:59 INFO - Running setup.py install for psutil 07:58:59 INFO - building 'psutil._psutil_linux' extension 07:58:59 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 07:59:00 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 07:59:00 INFO - building 'psutil._psutil_posix' extension 07:59:00 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 07:59:00 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 07:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:59:00 INFO - Successfully installed psutil 07:59:00 INFO - Cleaning up... 07:59:00 INFO - Return code: 0 07:59:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:59:00 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')]} 07:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:00 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')]} 07:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:00 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 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:00 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 07:59:00 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 07:59:00 INFO - Using env: {'DISPLAY': ':0', 07:59:00 INFO - 'HOME': '/home/cltbld', 07:59:00 INFO - 'LANG': 'en_US.UTF-8', 07:59:00 INFO - 'LANGUAGE': 'en_US:en', 07:59:00 INFO - 'LOGNAME': 'cltbld', 07:59:00 INFO - 'MAIL': '/var/mail/cltbld', 07:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:00 INFO - 'MOZ_NO_REMOTE': '1', 07:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:00 INFO - 'NO_EM_RESTART': '1', 07:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:00 INFO - 'PWD': '/builds/slave/test', 07:59:00 INFO - 'SHELL': '/bin/bash', 07:59:00 INFO - 'SHLVL': '1', 07:59:00 INFO - 'TERM': 'linux', 07:59:00 INFO - 'TMOUT': '86400', 07:59:00 INFO - 'USER': 'cltbld', 07:59:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:00 INFO - '_': '/tools/buildbot/bin/python'} 07:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:59:00 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 07:59:00 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 07:59:00 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 07:59:00 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 07:59:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:59:02 INFO - Installing collected packages: mozsystemmonitor 07:59:02 INFO - Running setup.py install for mozsystemmonitor 07:59:02 INFO - Successfully installed mozsystemmonitor 07:59:02 INFO - Cleaning up... 07:59:02 INFO - Return code: 0 07:59:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:59:02 INFO - Using env: {'DISPLAY': ':0', 07:59:02 INFO - 'HOME': '/home/cltbld', 07:59:02 INFO - 'LANG': 'en_US.UTF-8', 07:59:02 INFO - 'LANGUAGE': 'en_US:en', 07:59:02 INFO - 'LOGNAME': 'cltbld', 07:59:02 INFO - 'MAIL': '/var/mail/cltbld', 07:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:02 INFO - 'MOZ_NO_REMOTE': '1', 07:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:02 INFO - 'NO_EM_RESTART': '1', 07:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:02 INFO - 'PWD': '/builds/slave/test', 07:59:02 INFO - 'SHELL': '/bin/bash', 07:59:02 INFO - 'SHLVL': '1', 07:59:02 INFO - 'TERM': 'linux', 07:59:02 INFO - 'TMOUT': '86400', 07:59:02 INFO - 'USER': 'cltbld', 07:59:02 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:02 INFO - '_': '/tools/buildbot/bin/python'} 07:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:03 INFO - Downloading/unpacking jsonschema==2.5.1 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:04 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:04 INFO - warning: no files found matching '*.txt' 07:59:04 INFO - no previously-included directories found matching 'build' 07:59:04 INFO - no previously-included directories found matching 'dist' 07:59:04 INFO - no previously-included directories found matching '.git*' 07:59:04 INFO - Installing collected packages: jsonschema, functools32 07:59:04 INFO - Running setup.py install for functools32 07:59:04 INFO - warning: no files found matching '*.txt' 07:59:04 INFO - no previously-included directories found matching 'build' 07:59:04 INFO - no previously-included directories found matching 'dist' 07:59:04 INFO - no previously-included directories found matching '.git*' 07:59:04 INFO - Successfully installed jsonschema functools32 07:59:04 INFO - Cleaning up... 07:59:04 INFO - Return code: 0 07:59:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:59:04 INFO - Using env: {'DISPLAY': ':0', 07:59:04 INFO - 'HOME': '/home/cltbld', 07:59:04 INFO - 'LANG': 'en_US.UTF-8', 07:59:04 INFO - 'LANGUAGE': 'en_US:en', 07:59:04 INFO - 'LOGNAME': 'cltbld', 07:59:04 INFO - 'MAIL': '/var/mail/cltbld', 07:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:04 INFO - 'MOZ_NO_REMOTE': '1', 07:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:04 INFO - 'NO_EM_RESTART': '1', 07:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:04 INFO - 'PWD': '/builds/slave/test', 07:59:04 INFO - 'SHELL': '/bin/bash', 07:59:04 INFO - 'SHLVL': '1', 07:59:04 INFO - 'TERM': 'linux', 07:59:04 INFO - 'TMOUT': '86400', 07:59:04 INFO - 'USER': 'cltbld', 07:59:04 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:04 INFO - '_': '/tools/buildbot/bin/python'} 07:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:04 INFO - Cleaning up... 07:59:04 INFO - Return code: 0 07:59:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:59:04 INFO - Using env: {'DISPLAY': ':0', 07:59:04 INFO - 'HOME': '/home/cltbld', 07:59:04 INFO - 'LANG': 'en_US.UTF-8', 07:59:04 INFO - 'LANGUAGE': 'en_US:en', 07:59:04 INFO - 'LOGNAME': 'cltbld', 07:59:04 INFO - 'MAIL': '/var/mail/cltbld', 07:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:04 INFO - 'MOZ_NO_REMOTE': '1', 07:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:04 INFO - 'NO_EM_RESTART': '1', 07:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:04 INFO - 'PWD': '/builds/slave/test', 07:59:04 INFO - 'SHELL': '/bin/bash', 07:59:04 INFO - 'SHLVL': '1', 07:59:04 INFO - 'TERM': 'linux', 07:59:04 INFO - 'TMOUT': '86400', 07:59:04 INFO - 'USER': 'cltbld', 07:59:04 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:04 INFO - '_': '/tools/buildbot/bin/python'} 07:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:06 INFO - Downloading docopt-0.6.1.tar.gz 07:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:06 INFO - Running setup.py install for blobuploader 07:59:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:06 INFO - Running setup.py install for requests 07:59:07 INFO - Running setup.py install for docopt 07:59:07 INFO - Successfully installed blobuploader requests docopt 07:59:07 INFO - Cleaning up... 07:59:07 INFO - Return code: 0 07:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:07 INFO - Using env: {'DISPLAY': ':0', 07:59:07 INFO - 'HOME': '/home/cltbld', 07:59:07 INFO - 'LANG': 'en_US.UTF-8', 07:59:07 INFO - 'LANGUAGE': 'en_US:en', 07:59:07 INFO - 'LOGNAME': 'cltbld', 07:59:07 INFO - 'MAIL': '/var/mail/cltbld', 07:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:07 INFO - 'MOZ_NO_REMOTE': '1', 07:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:07 INFO - 'NO_EM_RESTART': '1', 07:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:07 INFO - 'PWD': '/builds/slave/test', 07:59:07 INFO - 'SHELL': '/bin/bash', 07:59:07 INFO - 'SHLVL': '1', 07:59:07 INFO - 'TERM': 'linux', 07:59:07 INFO - 'TMOUT': '86400', 07:59:07 INFO - 'USER': 'cltbld', 07:59:07 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:07 INFO - '_': '/tools/buildbot/bin/python'} 07:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:07 INFO - Running setup.py (path:/tmp/pip-FNS0WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:07 INFO - Running setup.py (path:/tmp/pip-t0FjiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:07 INFO - Running setup.py (path:/tmp/pip-nE8GBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:07 INFO - Running setup.py (path:/tmp/pip-2tj9sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:07 INFO - Running setup.py (path:/tmp/pip-ojW1Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:07 INFO - Running setup.py (path:/tmp/pip-ukhaEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:07 INFO - Running setup.py (path:/tmp/pip-awFxxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:07 INFO - Running setup.py (path:/tmp/pip-X8TtBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:08 INFO - Running setup.py (path:/tmp/pip-NPYBd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:08 INFO - Running setup.py (path:/tmp/pip-zFdTAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:08 INFO - Running setup.py (path:/tmp/pip-oupjxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:08 INFO - Running setup.py (path:/tmp/pip-0JiXj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:08 INFO - Running setup.py (path:/tmp/pip-BlbByb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:08 INFO - Running setup.py (path:/tmp/pip-VCwn_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:08 INFO - Running setup.py (path:/tmp/pip-IhKUqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:08 INFO - Running setup.py (path:/tmp/pip-WGhuTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:08 INFO - Running setup.py (path:/tmp/pip-vqkYW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:08 INFO - Running setup.py install for manifestparser 07:59:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:08 INFO - Running setup.py install for mozcrash 07:59:08 INFO - Running setup.py install for mozdebug 07:59:08 INFO - Running setup.py install for mozdevice 07:59:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for mozfile 07:59:09 INFO - Running setup.py install for mozhttpd 07:59:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for mozinfo 07:59:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for mozInstall 07:59:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for mozleak 07:59:09 INFO - Running setup.py install for mozlog 07:59:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for moznetwork 07:59:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for mozprocess 07:59:09 INFO - Running setup.py install for mozprofile 07:59:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:09 INFO - Running setup.py install for mozrunner 07:59:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:10 INFO - Running setup.py install for mozscreenshot 07:59:10 INFO - Running setup.py install for moztest 07:59:10 INFO - Running setup.py install for mozversion 07:59:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:10 INFO - Cleaning up... 07:59:10 INFO - Return code: 0 07:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:10 INFO - Using env: {'DISPLAY': ':0', 07:59:10 INFO - 'HOME': '/home/cltbld', 07:59:10 INFO - 'LANG': 'en_US.UTF-8', 07:59:10 INFO - 'LANGUAGE': 'en_US:en', 07:59:10 INFO - 'LOGNAME': 'cltbld', 07:59:10 INFO - 'MAIL': '/var/mail/cltbld', 07:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:10 INFO - 'MOZ_NO_REMOTE': '1', 07:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:10 INFO - 'NO_EM_RESTART': '1', 07:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:10 INFO - 'PWD': '/builds/slave/test', 07:59:10 INFO - 'SHELL': '/bin/bash', 07:59:10 INFO - 'SHLVL': '1', 07:59:10 INFO - 'TERM': 'linux', 07:59:10 INFO - 'TMOUT': '86400', 07:59:10 INFO - 'USER': 'cltbld', 07:59:10 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:10 INFO - '_': '/tools/buildbot/bin/python'} 07:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:10 INFO - Running setup.py (path:/tmp/pip-T5bYR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:10 INFO - Running setup.py (path:/tmp/pip-pu0ik1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:10 INFO - Running setup.py (path:/tmp/pip-GP3hVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:10 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)) 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:10 INFO - Running setup.py (path:/tmp/pip-rYZaE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:10 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)) 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:10 INFO - Running setup.py (path:/tmp/pip-X7l28z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:10 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)) 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:10 INFO - Running setup.py (path:/tmp/pip-bPbkBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:11 INFO - Running setup.py (path:/tmp/pip-T_I_yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:11 INFO - Running setup.py (path:/tmp/pip-WO7QiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:11 INFO - Running setup.py (path:/tmp/pip-IDNNAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:11 INFO - Running setup.py (path:/tmp/pip-omJl2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:11 INFO - Running setup.py (path:/tmp/pip-doQcMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:11 INFO - Running setup.py (path:/tmp/pip-1HyGSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:11 INFO - Running setup.py (path:/tmp/pip-3K8NCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:11 INFO - Running setup.py (path:/tmp/pip-KZMXFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:11 INFO - Running setup.py (path:/tmp/pip-MiBdNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:11 INFO - Running setup.py (path:/tmp/pip-X7Dj1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:11 INFO - Running setup.py (path:/tmp/pip-2wej7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:11 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)) 07:59:11 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)) 07:59:11 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)) 07:59:11 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)) 07:59:11 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)) 07:59:11 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)) 07:59:11 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)) 07:59:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:12 INFO - Downloading blessings-1.6.tar.gz 07:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:13 INFO - Installing collected packages: blessings 07:59:13 INFO - Running setup.py install for blessings 07:59:13 INFO - Successfully installed blessings 07:59:13 INFO - Cleaning up... 07:59:13 INFO - Return code: 0 07:59:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:13 INFO - Reading from file tmpfile_stdout 07:59:13 INFO - Current package versions: 07:59:13 INFO - argparse == 1.2.1 07:59:13 INFO - blessings == 1.6 07:59:13 INFO - blobuploader == 1.2.4 07:59:13 INFO - docopt == 0.6.1 07:59:13 INFO - functools32 == 3.2.3-2 07:59:13 INFO - jsonschema == 2.5.1 07:59:13 INFO - manifestparser == 1.1 07:59:13 INFO - mozInstall == 1.13 07:59:13 INFO - mozcrash == 1.0 07:59:13 INFO - mozdebug == 0.1 07:59:13 INFO - mozdevice == 0.51 07:59:13 INFO - mozfile == 1.2 07:59:13 INFO - mozhttpd == 0.7 07:59:13 INFO - mozinfo == 0.10 07:59:13 INFO - mozleak == 0.1 07:59:13 INFO - mozlog == 3.5 07:59:13 INFO - moznetwork == 0.27 07:59:13 INFO - mozprocess == 0.25 07:59:13 INFO - mozprofile == 0.28 07:59:13 INFO - mozrunner == 6.13 07:59:13 INFO - mozscreenshot == 0.1 07:59:13 INFO - mozsystemmonitor == 0.3 07:59:13 INFO - moztest == 0.8 07:59:13 INFO - mozversion == 1.4 07:59:13 INFO - psutil == 3.1.1 07:59:13 INFO - requests == 1.2.3 07:59:13 INFO - wsgiref == 0.1.2 07:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:59:13 INFO - Using env: {'DISPLAY': ':0', 07:59:13 INFO - 'HOME': '/home/cltbld', 07:59:13 INFO - 'LANG': 'en_US.UTF-8', 07:59:13 INFO - 'LANGUAGE': 'en_US:en', 07:59:13 INFO - 'LOGNAME': 'cltbld', 07:59:13 INFO - 'MAIL': '/var/mail/cltbld', 07:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:13 INFO - 'MOZ_NO_REMOTE': '1', 07:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:13 INFO - 'NO_EM_RESTART': '1', 07:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:13 INFO - 'PWD': '/builds/slave/test', 07:59:13 INFO - 'SHELL': '/bin/bash', 07:59:13 INFO - 'SHLVL': '1', 07:59:13 INFO - 'TERM': 'linux', 07:59:13 INFO - 'TMOUT': '86400', 07:59:13 INFO - 'USER': 'cltbld', 07:59:13 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:13 INFO - '_': '/tools/buildbot/bin/python'} 07:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:59:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:59:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:59:14 INFO - Installing collected packages: simplejson 07:59:14 INFO - Running setup.py install for simplejson 07:59:14 INFO - building 'simplejson._speedups' extension 07:59:14 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 07:59:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 07:59:15 INFO - Successfully installed simplejson 07:59:15 INFO - Cleaning up... 07:59:15 INFO - Return code: 0 07:59:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:15 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 0x1fb21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, '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': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', '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 07:59:15 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 07:59:15 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 07:59:15 INFO - Using env: {'DISPLAY': ':0', 07:59:15 INFO - 'HOME': '/home/cltbld', 07:59:15 INFO - 'LANG': 'en_US.UTF-8', 07:59:15 INFO - 'LANGUAGE': 'en_US:en', 07:59:15 INFO - 'LOGNAME': 'cltbld', 07:59:15 INFO - 'MAIL': '/var/mail/cltbld', 07:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:15 INFO - 'MOZ_NO_REMOTE': '1', 07:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:15 INFO - 'NO_EM_RESTART': '1', 07:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:15 INFO - 'PWD': '/builds/slave/test', 07:59:15 INFO - 'SHELL': '/bin/bash', 07:59:15 INFO - 'SHLVL': '1', 07:59:15 INFO - 'TERM': 'linux', 07:59:15 INFO - 'TMOUT': '86400', 07:59:15 INFO - 'USER': 'cltbld', 07:59:15 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:15 INFO - '_': '/tools/buildbot/bin/python'} 07:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:59:16 INFO - Cleaning up... 07:59:16 INFO - Return code: 0 07:59:16 INFO - Running post-action listener: _resource_record_post_action 07:59:16 INFO - Running post-action listener: _start_resource_monitoring 07:59:16 INFO - Starting resource monitoring. 07:59:16 INFO - [mozharness: 2017-08-25 14:59:16.081928Z] Finished create-virtualenv step (success) 07:59:16 INFO - [mozharness: 2017-08-25 14:59:16.082396Z] Running install step. 07:59:16 INFO - Running pre-action listener: _resource_record_pre_action 07:59:16 INFO - Running main action method: install 07:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:16 INFO - Reading from file tmpfile_stdout 07:59:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:16 INFO - Reading from file tmpfile_stdout 07:59:16 INFO - Output received: 07:59:16 INFO - Usage: mozinstall [options] installer 07:59:16 INFO - Options: 07:59:16 INFO - -h, --help show this help message and exit 07:59:16 INFO - -d DEST, --destination=DEST 07:59:16 INFO - Directory to install application into. [default: 07:59:16 INFO - "/builds/slave/test"] 07:59:16 INFO - --app=APP Application being installed. [default: firefox] 07:59:16 INFO - mkdir: /builds/slave/test/build/application 07:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:59:34 INFO - Reading from file tmpfile_stdout 07:59:34 INFO - Output received: 07:59:34 INFO - /builds/slave/test/build/application/firefox/firefox 07:59:34 INFO - Running post-action listener: _resource_record_post_action 07:59:34 INFO - [mozharness: 2017-08-25 14:59:34.079976Z] Finished install step (success) 07:59:34 INFO - [mozharness: 2017-08-25 14:59:34.080228Z] Running setup-mitmproxy step. 07:59:34 INFO - Running pre-action listener: _resource_record_pre_action 07:59:34 INFO - Running main action method: setup_mitmproxy 07:59:34 INFO - Skipping: mitmproxy is not required 07:59:34 INFO - Running post-action listener: _resource_record_post_action 07:59:34 INFO - [mozharness: 2017-08-25 14:59:34.081351Z] Finished setup-mitmproxy step (success) 07:59:34 INFO - [mozharness: 2017-08-25 14:59:34.081572Z] Running run-tests step. 07:59:34 INFO - Running pre-action listener: _resource_record_pre_action 07:59:34 INFO - Running pre-action listener: _set_gcov_prefix 07:59:34 INFO - Running main action method: run_tests 07:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:34 INFO - Python 2.7.3 07:59:34 INFO - Return code: 0 07:59:34 INFO - grabbing minidump binary from tooltool 07:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231e130>, '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 0x231f030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231f4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:59:34 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:59:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:59:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:34 INFO - Return code: 0 07:59:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:59:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:34 INFO - ENV: RUST_BACKTRACE is now full 07:59:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:59:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:34 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/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 07:59:34 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/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 07:59:34 INFO - Using env: {'DISPLAY': ':0', 07:59:34 INFO - 'HOME': '/home/cltbld', 07:59:34 INFO - 'LANG': 'en_US.UTF-8', 07:59:34 INFO - 'LANGUAGE': 'en_US:en', 07:59:34 INFO - 'LOGNAME': 'cltbld', 07:59:34 INFO - 'MAIL': '/var/mail/cltbld', 07:59:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:34 INFO - 'MOZ_NO_REMOTE': '1', 07:59:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:34 INFO - 'NO_EM_RESTART': '1', 07:59:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:34 INFO - 'PWD': '/builds/slave/test', 07:59:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:34 INFO - 'RUST_BACKTRACE': 'full', 07:59:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:59:34 INFO - 'SHELL': '/bin/bash', 07:59:34 INFO - 'SHLVL': '1', 07:59:34 INFO - 'STYLO_FORCE_ENABLED': '1', 07:59:34 INFO - 'TERM': 'linux', 07:59:34 INFO - 'TMOUT': '86400', 07:59:34 INFO - 'USER': 'cltbld', 07:59:34 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:34 INFO - '_': '/tools/buildbot/bin/python'} 07:59:34 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/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 07:59:34 INFO - mozversion application_buildid: 20170825141633 07:59:34 INFO - mozversion application_changeset: 56188620cce00b19700fbb8efaafea65e6ca8c61 07:59:34 INFO - mozversion application_display_name: Nightly 07:59:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:34 INFO - mozversion application_name: Firefox 07:59:34 INFO - mozversion application_remotingname: firefox 07:59:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:59:34 INFO - mozversion application_vendor: Mozilla 07:59:34 INFO - mozversion application_version: 57.0a1 07:59:34 INFO - mozversion platform_buildid: 20170825141633 07:59:34 INFO - mozversion platform_changeset: 56188620cce00b19700fbb8efaafea65e6ca8c61 07:59:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:59:34 INFO - mozversion platform_version: 57.0a1 07:59:34 INFO - using testdate: 1503673174 07:59:34 INFO - actual date: 1503673174 07:59:34 INFO - starting webserver on 'localhost:52077' 07:59:34 INFO - SUITE-START | Running 2 tests 07:59:34 INFO - TEST-START | dromaeo_css 07:59:34 INFO - Initialising browser for dromaeo_css test... 07:59:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52077/getInfo.html -profile /tmp/tmpl9kSKt/profile 07:59:34 INFO - TEST-INFO | started process 21228 (/builds/slave/test/build/application/firefox/firefox http://localhost:52077/getInfo.html) 07:59:40 INFO - TEST-INFO | 21228: exit 0 07:59:40 INFO - Browser initialized. 07:59:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:40 INFO - Using env: {'DISPLAY': ':0', 07:59:40 INFO - 'HOME': '/home/cltbld', 07:59:40 INFO - 'JSGC_DISABLE_POISONING': '1', 07:59:40 INFO - 'LANG': 'en_US.UTF-8', 07:59:40 INFO - 'LANGUAGE': 'en_US:en', 07:59:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:59:40 INFO - 'LOGNAME': 'cltbld', 07:59:40 INFO - 'MAIL': '/var/mail/cltbld', 07:59:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:59:40 INFO - 'MOZ_CRASHREPORTER': '1', 07:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:59:40 INFO - 'MOZ_NO_REMOTE': '1', 07:59:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:40 INFO - 'NO_EM_RESTART': '1', 07:59:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:40 INFO - 'PWD': '/builds/slave/test', 07:59:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:40 INFO - 'RUST_BACKTRACE': 'full', 07:59:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:59:40 INFO - 'SHELL': '/bin/bash', 07:59:40 INFO - 'SHLVL': '1', 07:59:40 INFO - 'STYLO_FORCE_ENABLED': '1', 07:59:40 INFO - 'TERM': 'linux', 07:59:40 INFO - 'TMOUT': '86400', 07:59:40 INFO - 'USER': 'cltbld', 07:59:40 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 07:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:40 INFO - '_': '/tools/buildbot/bin/python'} 07:59:40 INFO - TEST-INFO | started process 21415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl9kSKt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:41 INFO - PID 21415 | 07:59:41 INFO - PID 21415 | (/builds/slave/test/build/application/firefox/firefox:21464): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:59:41 INFO - PID 21415 | 07:59:42 INFO - PID 21415 | 07:59:42 INFO - PID 21415 | (/builds/slave/test/build/application/firefox/firefox:21527): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:59:42 INFO - PID 21415 | 07:59:42 INFO - PID 21415 | __metrics Screen width/height:1600/1200 07:59:42 INFO - PID 21415 | colorDepth:24 07:59:42 INFO - PID 21415 | Browser inner width/height: 1024/768 07:59:42 INFO - PID 21415 | __metrics 07:59:51 INFO - PID 21415 | RSS: Main: 174792704 07:59:51 INFO - PID 21415 | 08:02:50 INFO - PID 21415 | Cycle 1(1): loaded http://localhost:52077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52077/tests/dromaeo/cssquery-ext.html) 08:02:52 INFO - PID 21415 | RSS: Main: 178212864 08:02:52 INFO - PID 21415 | 08:05:54 INFO - PID 21415 | Cycle 1(1): loaded http://localhost:52077/tests/dromaeo/cssquery-ext.html (next: http://localhost:52077/tests/dromaeo/cssquery-jquery.html) 08:05:54 INFO - PID 21415 | RSS: Main: 174469120 08:05:54 INFO - PID 21415 | 08:08:56 INFO - PID 21415 | Cycle 1(1): loaded http://localhost:52077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52077/tests/dromaeo/cssquery-mootools.html) 08:08:57 INFO - PID 21415 | RSS: Main: 177332224 08:08:57 INFO - PID 21415 | 08:11:58 INFO - PID 21415 | Cycle 1(1): loaded http://localhost:52077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52077/tests/dromaeo/cssquery-prototype.html) 08:11:59 INFO - PID 21415 | RSS: Main: 175169536 08:11:59 INFO - PID 21415 | 08:15:03 INFO - PID 21415 | Cycle 1(1): loaded http://localhost:52077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52077/tests/dromaeo/cssquery-yui.html) 08:15:04 INFO - PID 21415 | RSS: Main: 177070080 08:15:04 INFO - PID 21415 | 08:18:05 INFO - PID 21415 | Cycle 1(1): loaded http://localhost:52077/tests/dromaeo/cssquery-yui.html (next: http://localhost:52077/tests/dromaeo/cssquery-dojo.html) 08:18:06 INFO - PID 21415 | RSS: Main: 179593216 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | __start_tp_report 08:18:06 INFO - PID 21415 | _x_x_mozilla_page_load 08:18:06 INFO - PID 21415 | _x_x_mozilla_page_load_details 08:18:06 INFO - PID 21415 | |i|pagename|runs| 08:18:06 INFO - PID 21415 | |0;dojo.html;3239.9308228284667;3314.9668503314965;3332.216929021681;3340.615829179645;3347.481140423235;6139.938600613992;6179.845503862406;6188.071789231612;6297.716602752876;6367.713452894619;6229.906551401721;6235.064740288959;6269.435750782429;6288.339724328948;6321.841953951153;5648.943510564904;5652.858678533049;5715.9428405716035;5762.510186634141;5779.855503612402;5575.0522411190195;5644.181593668915;5654.943450565504;5657.038303488417;5672.858178545528;5727.799527016556;5813.44772246638;5834.095715164114;5834.183214350016;5839.474447299721;5733.283339582552;5741.19623252745;5800.216970708942;5811.564132690065;5840.649561026309;5611.691356975365;5685.9147112792925;5715.828525144252;5759.712014399263;5764.394738552433;6206.906896396557;6235.532335074888;6239.688015599202;6263;6292.1820163378925;6609.93390066098;6639.767608133692;6660.766873159465;6673.766418175341;6692.63190524521;6721;6740.359665831738;6794.796156115324;6815.556988795713;6817.69320380584;6083.209182806251;6192.225971753531;6200;6208.410201030895;6334.2398912130375;6832.350926661959;6835.418989385858;6848.417884479775;6849.075374824434;6864.073350097773;6451.225852897683;6532.08550802888;6553.049807777941;6558.573692710054;6563.573367731177;6632.1046658701425;6662.600243985376;6664.333566643394;6672.86654266912;6675.9332406676285;6587.769428069994;6595.241547222035;6601.636909969901;6649.002649602501;6664.067030615718;6677.799666010027;6678.732850686015;6692.297308782605;6698.497612679069;6783.118194634764;5307.734613269321;5317.574594032468;5371.274877891435;5391.083515802323;5403.702796346239;4581.037982023746;4642.187617166982;4655.674102812771;4690.413698287714;4727.149113159664;5928.081147422156;5964.31410387811;5982.371850955674;5983.042713165873;5989.850253743604;6759.188897332351;6761.966190169018;6834.794956151323;6843.3840954314355;6853;5793.710314484259;5876.08920617305;5907.616004959664;5998.280206375263;6009.699515024231;5738.655680659173;5742.942570574324;5751.741171647286;5751.884962300731;5754.971225143931;6445.45213656835;6535.836604084936;6561.606303621894;6571.934280657228;6600.735970561123;6657.3009833966735;6715.697793599397;6754.628495432602;6783.966080169567;6791.2190098139345;6556.508261880283;6592.17597800275;6597;6674.866502669823;6684;6500;6533.705983230861;6567.179102612174;6600.735970561123;6655.667216639245;6781.491388146008;6790.66046697673;6802.387785099365;6813.1142951415995;6817.93182068173;6431.099646049463;6581.769638062645;6595.076689263603;6605.9009114864275;6608.966955165193;6494.772682956074;6522.5760325578685;6592.274849766618;6595.703193356215;6597.373249541286;6352.682365881595;6441.608016223361;6443.291237963726;6446.838829029124;6552.8361790955605;6306.779262725782;6369.20384951881;6379.202599675041;6386.105945167587;6387.520935929917;6109.541784366102;6196.194494715658;6199.690015499117;6345.175127233615;6439.034144878306 08:18:06 INFO - PID 21415 | |1;ext.html;735.6652723011031;810.5987536169597;835.6949713354624;838.3754103193119;1114.8829372915848;28892.711072889266;29554;38299.80850095746;39357;39684.60315396845;39022.80488597553;39406.21187576247;39648;39821.402678959836;39861.80069099658;7090.645467726619;7469.925300746977;7554.471187016911;7650.311471967521;7676.692932282702;7576.469647124703;7693.923060769376;7704.114026886896;7708.57602831844;7710.1904300048245;7663.885041724378;7710.537367757953;7716.382689384864;7728;7738.613069346538;7582.696692132308;7636.427267954898;7688.615569221516;7692.384609231248;7696.846063078707;7404.370628496585;7551.660175292125;7555.886661700079;7576.090869095744;7599.886001709923;35311.470327944844;35885.64114358849;35944.82027589872;36279.4558081629;36287.27425451476;3388.4409072503254;3417.043227896193;3422.401079811048;3428.5200071989943;3431.1765176357744;29538.55692164619;29556.113316600535;29610.25974350637;29696.703032969825;29718.257043573867;4812.663113582051;5021.59827213822;5034.295198672189;5073.137566613685;5074.391073071218;183884;184545;185131;186097.99999999863;186707;45323.54676453259;45479.54520454753;45572.31641525313;45589;45619;47056;47056.7647161762;47183.764081179375;47790.522094779306;48672.7566362173;13652.180869147884;13761.449542018407;13818.65453363674;13824.930875345559;13834.515791947233;11105.666829995112;11160.553577856796;11255.831162532568;12127.575534856238;12341.62975110748;12690;12800.80798788019;12838.486460541473;12893.677658058623;13064.608061758163;5301.151815709468;5393.325834270716;5416.864578385572;5507.614466987273;5536.4186760389575;937.9108984646448;968.1963969904962;968.6948611187454;976.6923419123095;989.4953573677476;19250.80749192518;19773.60452790936;19813;19890.204391824453;20020.299289524795;1064.5156453813652;1072.860528131338;1076.1283360478037;1078.6548304542628;1080.1143062688677;10878;10879.83680244797;11023.283486573348;11158.832617510743;11190;232432;233754;234875;235072;235554;46318.305225421645;46719.76640116778;46784;47088.5291147091;47134.528654713016;1392.0673148990202;1416.8653977872086;1422.6230049037013;1424.181095869879;1437.9640508987359;18950.905245473685;19202.90398548054;19283.51791205231;19603.509912252306;19627.80372196317;34590.82704586461;34610.307793844484;34667.826660866536;34670.13324666904;34682;192135;193399;193629;193997;194229;27350.179494615193;27929;27933;30430.84784576063;30743.231419213804;40113.39829902496;40147.59852401556;40291.395629065;40418.39372409475;40547.59452405438;29716;30471.08586742401;31885.043448696575;32403.675963240064;33141.834290829356;31975.6802431982;32371.35257294888;32441.35117297688;32644.83677581597;32713.34573308568;34683.47974780431;35317;35361;35408;35764.284714306086;31214.687853122086;31267.53098703476;31351.21621959469;31523.527147092354;31846.840765796023;23390.64914026325;23914.88042559776;23937.401564961016;24072.03711851506;24463.877680611484 08:18:06 INFO - PID 21415 | |2;jquery.html;561.8876224755047;568.4230506036376;571.191763654429;572.8739677271;572.9799457019005;21095.15619375225;21720.456988575275;21756.673649895263;21799.128034878624;22864;24080.75919240807;24766.380840478952;24771.876140619315;24793.50412991739;24808.131715389965;6524.282328943812;6640;6656.733730650768;6669.066330713704;6677.532572719887;5925.200097986782;6165.475934545547;6201.596896201732;6522.804315870531;6561.343865613424;6147.692615369236;6155.661438620874;6156.415140561639;6158.04550294705;6165.352637973016;6145.170401995718;6145.661988590626;6149.262088549381;6150.354212807635;6152.661603611799;5725.112607545795;5726.284214473191;5732.914006289909;5743.253377060997;5744.368119506851;28066.859665701744;29026.85486572575;29159.708402915912;29540.704592954226;29627.555586666003;1970.8916009619466;2005.8495612829097;2013.395981205647;2013.758348998115;2015.304719871642;18747.718784218247;19540.31608893682;19870.900645496826;19872.70190947137;19881.0059497026;2446.902123915041;2468.543319485901;2503.5243303772227;2509.4102885821817;2514.107491840389;130326;133967;134306;135211.32394338064;135225;14207.928960355339;14328.49850255236;14453.554644535463;14654;15086.54740357791;22671.093156273895;22727.431814204447;22733.09067637309;22746.317610471713;22868.771312286997;9893.258005649604;10011.899881001242;10037.648682296085;10101.393916365041;10198.643047493302;7999.680012799539;9114.40756350835;9150.908490915139;9153.22197613197;9248.630054797868;7893.881591776128;8755.868661970075;8850.20348168668;8863.568215892054;9087;2546.5416225079293;2587.58598624223;2596.4807038592357;2632.1577095329694;2653.6152257922495;902.2962089570145;937.4094320577992;961.5769061612868;966.0773960867355;968.8934217236099;18077.276908923497;18219.180136893872;18349.541261468305;18840;18924.148413321433;1004.372267332917;1008.5259927833906;1011.145581983223;1011.3325205364424;1027.1423361493087;10572.15422766177;10677.199210059276;10773.19201059908;10833.783324333626;10883.67348979532;507369;528929;530755;550795;553516;111150.44424777824;119314.40342798231;119410;119995;120701.99999999824;1171.912106592009;1179.1274456902001;1216.2276954134188;1221.6518292286833;1222.7187746818104;20509;20829.583408331444;20898.791012090292;20961;21241.575168496234;58878.116828248465;58992;59411.70294148502;59528.10707839299;62286.68856655688;69957.65021174861;70765;70954;71080.28919710737;71361.6431917837;14200.28998550089;14321.427142914166;14737.778933316224;14823.036502627294;14827.555173344817;22863.085476581415;23073.423164420354;23154;23417.531649367258;23647.763522364556;17693.646127077645;17852.19665115099;17860.285588576313;17959.281628735225;18003.729944051112;16152.19239038067;16798.664026719154;17080.82919170842;17324.826751732322;17411.216495258;17771.289148433916;17976.550586235448;18026.729599056285;18094.366697165537;18097.819021809613;14500.709985800437;14622.488212912496;14650.340734666752;14651.780223296872;14681.339339729951;17825.10874456246;17862.910685446488;17953.73069403934;17967.820321796615;17992.820071799113 08:18:06 INFO - PID 21415 | |3;mootools.html;1217.3913043478262;1281.205652495453;1288.4524077267165;1294.2428679222655;1300.53830890034;14265.358058887348;14873.330700118508;14878.628034299149;14881.107133571966;14886.106833589978;12361.567345142921;12784.616461506146;14572;15005.84994150058;15022.924885375585;2505.7619526144986;2558.2069558436942;2558.2325302409295;2560.975609756103;2562.1544890186287;2536.315194897386;2608.7652111309976;2627.671541057368;2635.2752992926908;2729.7952653551065;2718.4834881372476;2755.2423083651956;2763.392053748172;2765.225736793691;2767.501849667059;2640.6171105189737;2663.960040599383;2671.3455203475078;2673.6925253595696;2696.973030269711;2581;2582.3156863431204;2591;2594.1828324077856;2596.8701564921867;14325;14633.341499632543;14634.268286585628;14659.853401465956;14661.41354345825;7578.12851522071;7838.764837054898;7864.803379915491;7865.567393793339;7866.292033716935;5089.480707050034;5207.869803254911;5262.473752624745;5307.416184219733;5373.946260537384;1876.2776331112484;1885.123417610804;1892.7917929027797;1934.3713293179633;1938.9709154362695;25461.236162915142;25709.614355784677;25751.35621609456;25851.22446326613;25863;6466.1270728452;6469.838254043687;6606.933930660632;6691.631960242136;6712.798616041527;16708.081055541817;16734.665306693798;16853.494395168163;16890.74663880043;16904;7470.813229669193;7702.768916932501;7709.922900771033;7716.4212684048925;7718.498297610749;7095.361417472453;7152;7224.566526008456;7233.89149162763;7240.746573869889;5043.9747801260755;5092.38891333035;5193.870153246124;5236.214567814858;5248.370195576479;1317.1701827848585;1353.4180302469836;1383.9169649821042;1625.552972932453;1670.9582260443342;857.7083791510917;878.1920633017639;882.6469412235157;889.6485888074175;903.977400564978;8196.959015204886;8286.875696864552;8347.332213422911;8395.958020209982;8446.662133514714;945.1068740040596;949.3070058856935;950.2540505703129;952.7189479103681;963.2775418436173;5135.537801597874;5249.501297376743;5329;5392.649477783932;5417.702026388586;20471;20735.688964665544;20953.68569471459;21146.154153833675;21170.153193872073;20553.79446205519;20728;20734.481637959172;20794.792052079287;20842.47893802637;10894.346339219514;10906.636670416197;11183.664490065312;11198.832017519744;11212.887871121347;8053.637586308513;8172.6730930762105;8188.467749596257;8421.24208821209;8959.596818143069;17737.37919172823;17795.19921603505;18095.819041809413;18225.5419566437;18479.168437420616;18159.273629055217;18341.81658183401;18437.446876593724;18505;18687.345942891934;11859.762804744028;11988.64034078979;12059.81910271329;12108.515659373526;12122.212056216318;13365.465381384636;13546;13719.176849389069;13781.448742050607;13797.620237976122;11033.834492482458;11068.335899846035;11088.112950963743;11171.329720216812;11371.374574398156;10483.528241229316;10725.195610329101;10859.402732849454;10969;11086.61196858106;9160.816783664422;9169.633214671605;9265.629374824932;9275.07249275067;9306.022867598804;6856.117259946196;6926.896096558455;7047.436205103477;7087.3267039631155;7125.18060423058;7279.308465695751;7357.22749111357;7401.370883474965;7452.552846829208;7533.209013053551 08:18:06 INFO - PID 21415 | |4;prototype.html;480.98557043288713;499.8625378021045;509.55668568345544;518.7121147762991;521.7417378397694;6254.43710066094;6310.842228944273;6322.778702745405;6333.429991300782;6406.903896441557;6156.81529554113;6162.7843025494;6166.81499555014;6214.3474935131835;6268.529860260476;5120.103981803179;5122.8207012754565;5160.67769503723;5172.250023746555;5216.408995256445;4776.952230477703;4994.575461085812;5087.516685914832;5168.741562921858;5172.767225474862;4898.8040478381;4927.408710954691;4954.157793175169;4970.850874473772;5012.122878496249;4902.313676085351;4926.162552366106;4954.950450495521;4996.400431948153;4999.125328001999;4370.8907277318;4433.379326894237;4439.711418757803;4458.910821783546;4460.710053846489;6054;6061.242344706911;6080.348533371974;6118.235220597426;6201.472874805647;5558.888822223574;5663.1505274208785;5688.772449102031;5746.138079288098;5755.568332375088;6552.639604821733;6589.439897608709;6636.573136775568;6640.501962352843;6659.134312539339;4851.151048566522;4871.123197824426;4913.115639184945;4917.582005529534;4928.556429921288;6652.667366631746;6672.931391268722;6780.525363224576;6826.522143449961;6900.447964162905;4903.117438860968;4951.232558953368;4969.503049695001;4978.128827455181;4982.626303027288;5089.4147173074825;5101.9489805101475;5102.642815002914;5107.846764597068;5112.565431938253;5760.452756988079;5760.769569217268;5766.135079738073;5781.624194427349;5790.189373487715;6614.570052946639;6623.304553021863;6674.2658307586125;6701.597904125768;6727.428168605626;1721.9655606887793;1743.476956912921;1751.9211635476433;1753.0445906980726;1753.4476639858403;1172.8240763885315;1210.9636710898687;1224.7079331305558;1227.975440491203;1248.756492483957;5922.940770592239;5923.970380148072;5933.554983376264;5944.554158438048;5966.31387390447;6609.5373323867825;6758.594484330956;6768.593884366954;6769.763058292936;6782.74519213947;5866.6480011199465;5925.73334199962;5950.196723442366;5950.464458198783;5970.283565972111;3520.2607452435277;3526.453399723047;3552.1652411683235;3557.928841423157;3564.7167019872827;6502.869942601122;6528.053432252297;6641.501887358468;6667.366600172976;6693.598384096969;6862.382385585322;6911.9308806912295;6926.411255043377;6946.687399067054;7026.156861176692;6554.082428460115;6627.933720662828;6654.301298363602;6682.198136223587;6740;6709.865802683821;6735.360140786617;6802.3537763912345;6833.692483838338;6847.794566163023;6614.834629134118;6658.600483970978;6712.53012289135;6713;6749.595024298558;6624.205095388585;6631;6728.293529179561;6733.326667333227;6756.223034350916;4967.230079337708;4989.827390563142;5017.774200161075;5017.924731129109;5050;6522.771702990372;6726.495512836459;6771.289014653587;6827;6870.896936545856;6194.690265486798;6496.206631148462;6578.901316480161;6601.435224978458;6629.303923088007;6611.570247933869;6634.838903192019;6644.036614690939;6659.600423974577;6669.333066693292;6431.163948686641;6536.444402225864;6538.411542961157;6593;6612.173478315211;6702.966485167738;6709.832254193684;6713.395794378334;6714.630695311805;6736.888413411928;6474.223093228843;6474.676266186766;6486.708098135501;6497.707603157774;6499.122618446449 08:18:06 INFO - PID 21415 | |5;yui.html;859.2696208223007;880.2913654508119;889.4440974391006;899.8875140607424;901.5492253873066;17097.82902170978;18007.459776206717;21151.682724759143;22376.664350034764;22390.776092239073;19523.429710867396;20639.277625283117;20783.064762085705;20891.895540522313;20926.26758063468;923.5474617437441;943.2831048403194;948.7248697877607;949.7768024514234;950;864.2653744317342;948.3456415073612;958.8417911044669;964.4406244378279;964.5129209749067;987.4371608183338;1000.2797985450501;1000.4997501249376;1001.3291094966354;1001.3591301567003;989.673407775436;995.0397866059287;995.5221493683073;995.5967833027636;997.8203923293804;733.0104359115152;736.0651971995536;738.7045181927218;738.7119023580753;738.7414404958275;19036.42890713281;19386.4184074478;19459.318923837738;19645.607087858163;19675.60648787016;20809.479763006046;20866.478338041517;20910.686339704916;21500.247491337883;21546.56906861854;16642.33430662772;17029.744553831704;17202;17219.65560688779;17230.138493075297;3535.9469607955903;3575.1598374382;3590.1563132664064;3591.4253719405033;3604.819759012039;126636.36681816624;126690;128963;129063;131159;16087.919560402122;16240.51278461648;16272.105034222994;16708.99746015243;16760.329586816635;26156.476870462866;26168.8691556541;26294;26333.34166645849;26335.34161645974;7759.146493885668;7849.607519623996;7874.448788584744;7875.803104922423;7881.369490440751;3982.74112182713;4048.838046478108;4076.286649836267;4080.489938757655;4080.5511393746665;5103.464136265638;5172.663776854492;5199.986002729507;5220.243064755665;5224.164133738584;926.6941909169958;939.2579861909152;955.3074021334477;958.9520523973913;959;661.2659947458318;672.7914346552584;682.6791408038214;686.498855835243;693.3655705029842;9776.706698799047;9945.701628951143;9972.80054398908;10134.23993200513;10698.62554810578;644.5939058393183;648.5816648261939;654.1855390039432;659.650385295794;660.9900851487232;4963.255511673206;5021.372328458942;5045.722485263345;5059.494050594911;5129.615278854101;111528;111581;111693.32460013106;112431.43784281026;115206;75433.83460897501;94974;97168;101227.98772012333;101358;62753.68623156855;88540.5572972131;89297.55351223203;90009.09990900138;90853;11741.706457338634;11874.678377473641;12026.15816892809;12395.62813115608;12504.062195335204;39241;40018.799906000284;40073.79963100166;41279.58720412877;41352;69173.30826691669;70644.64677676579;70666.29333706597;70853;72617.6369118151;16511.587210319838;16969.660606788042;17104.828951710322;17167.31330746756;17219.65560688804;17845.821541784935;18491;18543.258269669062;18657.440276791716;19412;17582.472525824247;17595.120243987494;17814.198361073522;17841.821581784017;17917.820821791614;18661.533461663566;18943.33698320552;18945.621087578445;19137.330193443162;19489.220431182595;16295.51113466598;17532.386366477112;18092.366767163086;18194.72707909409;18317.3588924387;13193.670158246121;13513.797293040416;13573.1856088635;13698.657533561342;13902;12154;12262.938685306874;12596.622101336974;12756.107072505207;12993.480260789462 08:18:06 INFO - PID 21415 | __end_tp_report 08:18:06 INFO - PID 21415 | __start_cc_report 08:18:06 INFO - PID 21415 | _x_x_mozilla_cycle_collect,379 08:18:06 INFO - PID 21415 | __end_cc_report 08:18:06 INFO - PID 21415 | __startTimestamp1503674286122__endTimestamp 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | ------- Summary: start ------- 08:18:06 INFO - PID 21415 | Number of tests: 6 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | [#0] dojo.html Cycles:165 Average:6171.50 Median:6379.20 stddev:708.24 (11.1%) stddev-sans-first:672.04 08:18:06 INFO - PID 21415 | Values: 3239.9 3315.0 3332.2 3340.6 3347.5 6139.9 6179.8 6188.1 6297.7 6367.7 6229.9 6235.1 6269.4 6288.3 6321.8 5648.9 5652.9 5715.9 5762.5 5779.9 5575.1 5644.2 5654.9 5657.0 5672.9 5727.8 5813.4 5834.1 5834.2 5839.5 5733.3 5741.2 5800.2 5811.6 5840.6 5611.7 5685.9 5715.8 5759.7 5764.4 6206.9 6235.5 6239.7 6263.0 6292.2 6609.9 6639.8 6660.8 6673.8 6692.6 6721.0 6740.4 6794.8 6815.6 6817.7 6083.2 6192.2 6200.0 6208.4 6334.2 6832.4 6835.4 6848.4 6849.1 6864.1 6451.2 6532.1 6553.0 6558.6 6563.6 6632.1 6662.6 6664.3 6672.9 6675.9 6587.8 6595.2 6601.6 6649.0 6664.1 6677.8 6678.7 6692.3 6698.5 6783.1 5307.7 5317.6 5371.3 5391.1 5403.7 4581.0 4642.2 4655.7 4690.4 4727.1 5928.1 5964.3 5982.4 5983.0 5989.9 6759.2 6762.0 6834.8 6843.4 6853.0 5793.7 5876.1 5907.6 5998.3 6009.7 5738.7 5742.9 5751.7 5751.9 5755.0 6445.5 6535.8 6561.6 6571.9 6600.7 6657.3 6715.7 6754.6 6784.0 6791.2 6556.5 6592.2 6597.0 6674.9 6684.0 6500.0 6533.7 6567.2 6600.7 6655.7 6781.5 6790.7 6802.4 6813.1 6817.9 6431.1 6581.8 6595.1 6605.9 6609.0 6494.8 6522.6 6592.3 6595.7 6597.4 6352.7 6441.6 6443.3 6446.8 6552.8 6306.8 6369.2 6379.2 6386.1 6387.5 6109.5 6196.2 6199.7 6345.2 6439.0 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | [#1] ext.html Cycles:180 Average:36008.94 Median:3425.46 stddev:53317.13 (1556.5%) stddev-sans-first:53400.91 08:18:06 INFO - PID 21415 | Values: 735.7 810.6 835.7 838.4 1114.9 28892.7 29554.0 38299.8 39357.0 39684.6 39022.8 39406.2 39648.0 39821.4 39861.8 7090.6 7469.9 7554.5 7650.3 7676.7 7576.5 7693.9 7704.1 7708.6 7710.2 7663.9 7710.5 7716.4 7728.0 7738.6 7582.7 7636.4 7688.6 7692.4 7696.8 7404.4 7551.7 7555.9 7576.1 7599.9 35311.5 35885.6 35944.8 36279.5 36287.3 3388.4 3417.0 3422.4 3428.5 3431.2 29538.6 29556.1 29610.3 29696.7 29718.3 4812.7 5021.6 5034.3 5073.1 5074.4 183884.0 184545.0 185131.0 186098.0 186707.0 45323.5 45479.5 45572.3 45589.0 45619.0 47056.0 47056.8 47183.8 47790.5 48672.8 13652.2 13761.4 13818.7 13824.9 13834.5 11105.7 11160.6 11255.8 12127.6 12341.6 12690.0 12800.8 12838.5 12893.7 13064.6 5301.2 5393.3 5416.9 5507.6 5536.4 937.9 968.2 968.7 976.7 989.5 19250.8 19773.6 19813.0 19890.2 20020.3 1064.5 1072.9 1076.1 1078.7 1080.1 10878.0 10879.8 11023.3 11158.8 11190.0 232432.0 233754.0 234875.0 235072.0 235554.0 46318.3 46719.8 46784.0 47088.5 47134.5 1392.1 1416.9 1422.6 1424.2 1438.0 18950.9 19202.9 19283.5 19603.5 19627.8 34590.8 34610.3 34667.8 34670.1 34682.0 192135.0 193399.0 193629.0 193997.0 194229.0 27350.2 27929.0 27933.0 30430.8 30743.2 40113.4 40147.6 40291.4 40418.4 40547.6 29716.0 30471.1 31885.0 32403.7 33141.8 31975.7 32371.4 32441.4 32644.8 32713.3 34683.5 35317.0 35361.0 35408.0 35764.3 31214.7 31267.5 31351.2 31523.5 31846.8 23390.6 23914.9 23937.4 24072.0 24463.9 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | [#2] jquery.html Cycles:180 Average:35889.78 Median:22739.70 stddev:89450.66 (393.4%) stddev-sans-first:89662.26 08:18:06 INFO - PID 21415 | Values: 561.9 568.4 571.2 572.9 573.0 21095.2 21720.5 21756.7 21799.1 22864.0 24080.8 24766.4 24771.9 24793.5 24808.1 6524.3 6640.0 6656.7 6669.1 6677.5 5925.2 6165.5 6201.6 6522.8 6561.3 6147.7 6155.7 6156.4 6158.0 6165.4 6145.2 6145.7 6149.3 6150.4 6152.7 5725.1 5726.3 5732.9 5743.3 5744.4 28066.9 29026.9 29159.7 29540.7 29627.6 1970.9 2005.8 2013.4 2013.8 2015.3 18747.7 19540.3 19870.9 19872.7 19881.0 2446.9 2468.5 2503.5 2509.4 2514.1 130326.0 133967.0 134306.0 135211.3 135225.0 14207.9 14328.5 14453.6 14654.0 15086.5 22671.1 22727.4 22733.1 22746.3 22868.8 9893.3 10011.9 10037.6 10101.4 10198.6 7999.7 9114.4 9150.9 9153.2 9248.6 7893.9 8755.9 8850.2 8863.6 9087.0 2546.5 2587.6 2596.5 2632.2 2653.6 902.3 937.4 961.6 966.1 968.9 18077.3 18219.2 18349.5 18840.0 18924.1 1004.4 1008.5 1011.1 1011.3 1027.1 10572.2 10677.2 10773.2 10833.8 10883.7 507369.0 528929.0 530755.0 550795.0 553516.0 111150.4 119314.4 119410.0 119995.0 120702.0 1171.9 1179.1 1216.2 1221.7 1222.7 20509.0 20829.6 20898.8 20961.0 21241.6 58878.1 58992.0 59411.7 59528.1 62286.7 69957.7 70765.0 70954.0 71080.3 71361.6 14200.3 14321.4 14737.8 14823.0 14827.6 22863.1 23073.4 23154.0 23417.5 23647.8 17693.6 17852.2 17860.3 17959.3 18003.7 16152.2 16798.7 17080.8 17324.8 17411.2 17771.3 17976.6 18026.7 18094.4 18097.8 14500.7 14622.5 14650.3 14651.8 14681.3 17825.1 17862.9 17953.7 17967.8 17992.8 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | [#3] mootools.html Cycles:180 Average:9101.48 Median:14216.77 stddev:6443.52 (45.3%) stddev-sans-first:6434.37 08:18:06 INFO - PID 21415 | Values: 1217.4 1281.2 1288.5 1294.2 1300.5 14265.4 14873.3 14878.6 14881.1 14886.1 12361.6 12784.6 14572.0 15005.8 15022.9 2505.8 2558.2 2558.2 2561.0 2562.2 2536.3 2608.8 2627.7 2635.3 2729.8 2718.5 2755.2 2763.4 2765.2 2767.5 2640.6 2664.0 2671.3 2673.7 2697.0 2581.0 2582.3 2591.0 2594.2 2596.9 14325.0 14633.3 14634.3 14659.9 14661.4 7578.1 7838.8 7864.8 7865.6 7866.3 5089.5 5207.9 5262.5 5307.4 5373.9 1876.3 1885.1 1892.8 1934.4 1939.0 25461.2 25709.6 25751.4 25851.2 25863.0 6466.1 6469.8 6606.9 6691.6 6712.8 16708.1 16734.7 16853.5 16890.7 16904.0 7470.8 7702.8 7709.9 7716.4 7718.5 7095.4 7152.0 7224.6 7233.9 7240.7 5044.0 5092.4 5193.9 5236.2 5248.4 1317.2 1353.4 1383.9 1625.6 1671.0 857.7 878.2 882.6 889.6 904.0 8197.0 8286.9 8347.3 8396.0 8446.7 945.1 949.3 950.3 952.7 963.3 5135.5 5249.5 5329.0 5392.6 5417.7 20471.0 20735.7 20953.7 21146.2 21170.2 20553.8 20728.0 20734.5 20794.8 20842.5 10894.3 10906.6 11183.7 11198.8 11212.9 8053.6 8172.7 8188.5 8421.2 8959.6 17737.4 17795.2 18095.8 18225.5 18479.2 18159.3 18341.8 18437.4 18505.0 18687.3 11859.8 11988.6 12059.8 12108.5 12122.2 13365.5 13546.0 13719.2 13781.4 13797.6 11033.8 11068.3 11088.1 11171.3 11371.4 10483.5 10725.2 10859.4 10969.0 11086.6 9160.8 9169.6 9265.6 9275.1 9306.0 6856.1 6926.9 7047.4 7087.3 7125.2 7279.3 7357.2 7401.4 7452.6 7533.2 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | [#4] prototype.html Cycles:180 Average:5562.45 Median:6164.80 stddev:1572.93 (25.5%) stddev-sans-first:1530.40 08:18:06 INFO - PID 21415 | Values: 481.0 499.9 509.6 518.7 521.7 6254.4 6310.8 6322.8 6333.4 6406.9 6156.8 6162.8 6166.8 6214.3 6268.5 5120.1 5122.8 5160.7 5172.3 5216.4 4777.0 4994.6 5087.5 5168.7 5172.8 4898.8 4927.4 4954.2 4970.9 5012.1 4902.3 4926.2 4955.0 4996.4 4999.1 4370.9 4433.4 4439.7 4458.9 4460.7 6054.0 6061.2 6080.3 6118.2 6201.5 5558.9 5663.2 5688.8 5746.1 5755.6 6552.6 6589.4 6636.6 6640.5 6659.1 4851.2 4871.1 4913.1 4917.6 4928.6 6652.7 6672.9 6780.5 6826.5 6900.4 4903.1 4951.2 4969.5 4978.1 4982.6 5089.4 5101.9 5102.6 5107.8 5112.6 5760.5 5760.8 5766.1 5781.6 5790.2 6614.6 6623.3 6674.3 6701.6 6727.4 1722.0 1743.5 1751.9 1753.0 1753.4 1172.8 1211.0 1224.7 1228.0 1248.8 5922.9 5924.0 5933.6 5944.6 5966.3 6609.5 6758.6 6768.6 6769.8 6782.7 5866.6 5925.7 5950.2 5950.5 5970.3 3520.3 3526.5 3552.2 3557.9 3564.7 6502.9 6528.1 6641.5 6667.4 6693.6 6862.4 6911.9 6926.4 6946.7 7026.2 6554.1 6627.9 6654.3 6682.2 6740.0 6709.9 6735.4 6802.4 6833.7 6847.8 6614.8 6658.6 6712.5 6713.0 6749.6 6624.2 6631.0 6728.3 6733.3 6756.2 4967.2 4989.8 5017.8 5017.9 5050.0 6522.8 6726.5 6771.3 6827.0 6870.9 6194.7 6496.2 6578.9 6601.4 6629.3 6611.6 6634.8 6644.0 6659.6 6669.3 6431.2 6536.4 6538.4 6593.0 6612.2 6703.0 6709.8 6713.4 6714.6 6736.9 6474.2 6474.7 6486.7 6497.7 6499.1 08:18:06 INFO - PID 21415 | 08:18:06 INFO - PID 21415 | [#5] yui.html Cycles:180 Average:23429.10 Median:26313.67 stddev:32359.68 (123.0%) stddev-sans-first:32406.07 08:18:06 INFO - PID 21415 | Values: 859.3 880.3 889.4 899.9 901.5 17097.8 18007.5 21151.7 22376.7 22390.8 19523.4 20639.3 20783.1 20891.9 20926.3 923.5 943.3 948.7 949.8 950.0 864.3 948.3 958.8 964.4 964.5 987.4 1000.3 1000.5 1001.3 1001.4 989.7 995.0 995.5 995.6 997.8 733.0 736.1 738.7 738.7 738.7 19036.4 19386.4 19459.3 19645.6 19675.6 20809.5 20866.5 20910.7 21500.2 21546.6 16642.3 17029.7 17202.0 17219.7 17230.1 3535.9 3575.2 3590.2 3591.4 3604.8 126636.4 126690.0 128963.0 129063.0 131159.0 16087.9 16240.5 16272.1 16709.0 16760.3 26156.5 26168.9 26294.0 26333.3 26335.3 7759.1 7849.6 7874.4 7875.8 7881.4 3982.7 4048.8 4076.3 4080.5 4080.6 5103.5 5172.7 5200.0 5220.2 5224.2 926.7 939.3 955.3 959.0 959.0 661.3 672.8 682.7 686.5 693.4 9776.7 9945.7 9972.8 10134.2 10698.6 644.6 648.6 654.2 659.7 661.0 4963.3 5021.4 5045.7 5059.5 5129.6 111528.0 111581.0 111693.3 112431.4 115206.0 75433.8 94974.0 97168.0 101228.0 101358.0 62753.7 88540.6 89297.6 90009.1 90853.0 11741.7 11874.7 12026.2 12395.6 12504.1 39241.0 40018.8 40073.8 41279.6 41352.0 69173.3 70644.6 70666.3 70853.0 72617.6 16511.6 16969.7 17104.8 17167.3 17219.7 17845.8 18491.0 18543.3 18657.4 19412.0 17582.5 17595.1 17814.2 17841.8 17917.8 18661.5 18943.3 18945.6 19137.3 19489.2 16295.5 17532.4 18092.4 18194.7 18317.4 13193.7 13513.8 13573.2 13698.7 13902.0 12154.0 12262.9 12596.6 12756.1 12993.5 08:18:06 INFO - PID 21415 | -------- Summary: end -------- 08:18:06 INFO - PID 21415 | 08:18:06 INFO - TEST-INFO | 21415: exit 0 08:18:06 INFO - TEST-OK | dromaeo_css | took 1112410ms 08:18:06 INFO - TEST-START | kraken 08:18:06 INFO - Initialising browser for kraken test... 08:18:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52077/getInfo.html -profile /tmp/tmpmyC6IH/profile 08:18:06 INFO - TEST-INFO | started process 21836 (/builds/slave/test/build/application/firefox/firefox http://localhost:52077/getInfo.html) 08:18:12 INFO - TEST-INFO | 21836: exit 0 08:18:12 INFO - Browser initialized. 08:18:12 INFO - Running cycle 1/1 for kraken test... 08:18:12 INFO - Using env: {'DISPLAY': ':0', 08:18:12 INFO - 'HOME': '/home/cltbld', 08:18:12 INFO - 'JSGC_DISABLE_POISONING': '1', 08:18:12 INFO - 'LANG': 'en_US.UTF-8', 08:18:12 INFO - 'LANGUAGE': 'en_US:en', 08:18:12 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:18:12 INFO - 'LOGNAME': 'cltbld', 08:18:12 INFO - 'MAIL': '/var/mail/cltbld', 08:18:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:18:12 INFO - 'MOZ_CRASHREPORTER': '1', 08:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:12 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:18:12 INFO - 'MOZ_NO_REMOTE': '1', 08:18:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:12 INFO - 'NO_EM_RESTART': '1', 08:18:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:12 INFO - 'PWD': '/builds/slave/test', 08:18:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:12 INFO - 'RUST_BACKTRACE': 'full', 08:18:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:18:12 INFO - 'SHELL': '/bin/bash', 08:18:12 INFO - 'SHLVL': '1', 08:18:12 INFO - 'STYLO_FORCE_ENABLED': '1', 08:18:12 INFO - 'TERM': 'linux', 08:18:12 INFO - 'TMOUT': '86400', 08:18:12 INFO - 'USER': 'cltbld', 08:18:12 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1503668027.538621-853868537', 08:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:12 INFO - '_': '/tools/buildbot/bin/python'} 08:18:12 INFO - TEST-INFO | started process 22024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyC6IH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:13 INFO - PID 22024 | 08:18:13 INFO - PID 22024 | (/builds/slave/test/build/application/firefox/firefox:22073): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:18:13 INFO - PID 22024 | 08:18:14 INFO - PID 22024 | 08:18:14 INFO - PID 22024 | (/builds/slave/test/build/application/firefox/firefox:22132): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:18:14 INFO - PID 22024 | 08:18:14 INFO - PID 22024 | __metrics Screen width/height:1600/1200 08:18:14 INFO - PID 22024 | colorDepth:24 08:18:14 INFO - PID 22024 | Browser inner width/height: 1024/768 08:18:14 INFO - PID 22024 | __metrics 08:18:24 INFO - PID 22024 | RSS: Main: 174714880 08:18:24 INFO - PID 22024 | 08:18:26 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52077/tests/kraken/driver.html?testName=audio-beat-detection) 08:18:27 INFO - PID 22024 | RSS: Main: 180060160 08:18:27 INFO - PID 22024 | 08:18:30 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52077/tests/kraken/driver.html?testName=audio-dft) 08:18:31 INFO - PID 22024 | RSS: Main: 181698560 08:18:31 INFO - PID 22024 | 08:18:34 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52077/tests/kraken/driver.html?testName=audio-fft) 08:18:34 INFO - PID 22024 | RSS: Main: 174501888 08:18:34 INFO - PID 22024 | 08:18:36 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52077/tests/kraken/driver.html?testName=audio-oscillator) 08:18:37 INFO - PID 22024 | RSS: Main: 174891008 08:18:37 INFO - PID 22024 | 08:18:39 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:40 INFO - PID 22024 | RSS: Main: 175480832 08:18:40 INFO - PID 22024 | 08:18:43 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52077/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:44 INFO - PID 22024 | RSS: Main: 176369664 08:18:44 INFO - PID 22024 | 08:18:47 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52077/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:48 INFO - PID 22024 | RSS: Main: 176640000 08:18:48 INFO - PID 22024 | 08:18:51 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52077/tests/kraken/driver.html?testName=json-parse-financial) 08:18:51 INFO - PID 22024 | RSS: Main: 176939008 08:18:51 INFO - PID 22024 | 08:18:53 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:54 INFO - PID 22024 | RSS: Main: 177164288 08:18:54 INFO - PID 22024 | 08:18:55 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:56 INFO - PID 22024 | RSS: Main: 177586176 08:18:56 INFO - PID 22024 | 08:18:58 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:59 INFO - PID 22024 | RSS: Main: 177287168 08:18:59 INFO - PID 22024 | 08:19:02 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:02 INFO - PID 22024 | RSS: Main: 177569792 08:19:02 INFO - PID 22024 | 08:19:05 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:06 INFO - PID 22024 | RSS: Main: 177762304 08:19:06 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | Cycle 1(1): loaded http://localhost:52077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52077/tests/kraken/driver.html?testName=ai-astar) 08:19:08 INFO - PID 22024 | RSS: Main: 179462144 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | __start_tp_report 08:19:08 INFO - PID 22024 | _x_x_mozilla_page_load 08:19:08 INFO - PID 22024 | _x_x_mozilla_page_load_details 08:19:08 INFO - PID 22024 | |i|pagename|runs| 08:19:08 INFO - PID 22024 | |0;ai-astar;97;108;99;113;117;109;108;113;112;116 08:19:08 INFO - PID 22024 | |1;audio-beat-detection;147;118;144;173;122;149;145;118;169;120 08:19:08 INFO - PID 22024 | |2;audio-dft;174;163;163;162;163;169;169;168;171;164 08:19:08 INFO - PID 22024 | |3;audio-fft;75;75;74;169;76;74;72;78;158;75 08:19:08 INFO - PID 22024 | |4;audio-oscillator;79;87;133;79;79;83;130;79;78;132 08:19:08 INFO - PID 22024 | |5;imaging-gaussian-blur;113;114;115;114;114;114;114;114;122;117 08:19:08 INFO - PID 22024 | |6;imaging-darkroom;151;147;148;147;148;147;148;149;148;149 08:19:08 INFO - PID 22024 | |7;imaging-desaturate;93;94;93;93;94;96;98;99;94;94 08:19:08 INFO - PID 22024 | |8;json-parse-financial;52;51;51;51;52;52;52;57;55;51 08:19:08 INFO - PID 22024 | |9;json-stringify-tinderbox;56;56;55;55;62;59;55;59;56;55 08:19:08 INFO - PID 22024 | |10;stanford-crypto-aes;75;79;74;76;80;86;81;78;75;76 08:19:08 INFO - PID 22024 | |11;stanford-crypto-ccm;127;119;122;125;123;124;119;117;121;155 08:19:08 INFO - PID 22024 | |12;stanford-crypto-pbkdf2;174;170;176;179;169;177;168;178;169;174 08:19:08 INFO - PID 22024 | |13;stanford-crypto-sha256-iterative;66;67;64;75;65;64;64;64;64;63 08:19:08 INFO - PID 22024 | __end_tp_report 08:19:08 INFO - PID 22024 | __start_cc_report 08:19:08 INFO - PID 22024 | _x_x_mozilla_cycle_collect,970 08:19:08 INFO - PID 22024 | __end_cc_report 08:19:08 INFO - PID 22024 | __startTimestamp1503674348575__endTimestamp 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | ------- Summary: start ------- 08:19:08 INFO - PID 22024 | Number of tests: 14 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#0] ai-astar Cycles:10 Average:109.20 Median:114.50 stddev:6.66 (5.8%) stddev-sans-first:5.41 08:19:08 INFO - PID 22024 | Values: 97.0 108.0 99.0 113.0 117.0 109.0 108.0 113.0 112.0 116.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:146.00 stddev:20.52 (14.1%) stddev-sans-first:21.63 08:19:08 INFO - PID 22024 | Values: 147.0 118.0 144.0 173.0 122.0 149.0 145.0 118.0 169.0 120.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#2] audio-dft Cycles:10 Average:166.60 Median:168.50 stddev:4.14 (2.5%) stddev-sans-first:3.42 08:19:08 INFO - PID 22024 | Values: 174.0 163.0 163.0 162.0 163.0 169.0 169.0 168.0 171.0 164.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#3] audio-fft Cycles:10 Average:92.60 Median:75.00 stddev:37.49 (50.0%) stddev-sans-first:39.22 08:19:08 INFO - PID 22024 | Values: 75.0 75.0 74.0 169.0 76.0 74.0 72.0 78.0 158.0 75.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:79.00 stddev:24.83 (31.4%) stddev-sans-first:25.58 08:19:08 INFO - PID 22024 | Values: 79.0 87.0 133.0 79.0 79.0 83.0 130.0 79.0 78.0 132.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:114.00 stddev:2.64 (2.3%) stddev-sans-first:2.69 08:19:08 INFO - PID 22024 | Values: 113.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 122.0 117.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:0.78 08:19:08 INFO - PID 22024 | Values: 151.0 147.0 148.0 147.0 148.0 147.0 148.0 149.0 148.0 149.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.15 (2.3%) stddev-sans-first:2.18 08:19:08 INFO - PID 22024 | Values: 93.0 94.0 93.0 93.0 94.0 96.0 98.0 99.0 94.0 94.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:2.01 (3.9%) stddev-sans-first:2.13 08:19:08 INFO - PID 22024 | Values: 52.0 51.0 51.0 51.0 52.0 52.0 52.0 57.0 55.0 51.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:2.39 (4.3%) stddev-sans-first:2.52 08:19:08 INFO - PID 22024 | Values: 56.0 56.0 55.0 55.0 62.0 59.0 55.0 59.0 56.0 55.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.50 stddev:3.65 (4.7%) stddev-sans-first:3.71 08:19:08 INFO - PID 22024 | Values: 75.0 79.0 74.0 76.0 80.0 86.0 81.0 78.0 75.0 76.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:123.50 stddev:10.90 (8.8%) stddev-sans-first:11.54 08:19:08 INFO - PID 22024 | Values: 127.0 119.0 122.0 125.0 123.0 124.0 119.0 117.0 121.0 155.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.00 stddev:4.12 (2.4%) stddev-sans-first:4.36 08:19:08 INFO - PID 22024 | Values: 174.0 170.0 176.0 179.0 169.0 177.0 168.0 178.0 169.0 174.0 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:64.50 stddev:3.50 (5.4%) stddev-sans-first:3.71 08:19:08 INFO - PID 22024 | Values: 66.0 67.0 64.0 75.0 65.0 64.0 64.0 64.0 64.0 63.0 08:19:08 INFO - PID 22024 | -------- Summary: end -------- 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150082,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | 08:19:08 INFO - PID 22024 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 08:19:08 INFO - PID 22024 | 08:19:09 INFO - PID 22024 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:19:09 INFO - TEST-INFO | 22024: exit 0 08:19:09 INFO - TEST-OK | kraken | took 62625ms 08:19:09 INFO - SUITE-END | took 1175s 08:19:09 INFO - Completed test suite (00:19:35) 08:19:09 INFO - javascript benchmark 08:19:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8377.325676077864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3239.9308228284667, 3314.9668503314965, 3332.216929021681, 3340.615829179645, 3347.481140423235, 6139.938600613992, 6179.845503862406, 6188.071789231612, 6297.716602752876, 6367.713452894619, 6229.906551401721, 6235.064740288959, 6269.435750782429, 6288.339724328948, 6321.841953951153, 5648.943510564904, 5652.858678533049, 5715.9428405716035, 5762.510186634141, 5779.855503612402, 5575.0522411190195, 5644.181593668915, 5654.943450565504, 5657.038303488417, 5672.858178545528, 5727.799527016556, 5813.44772246638, 5834.095715164114, 5834.183214350016, 5839.474447299721, 5733.283339582552, 5741.19623252745, 5800.216970708942, 5811.564132690065, 5840.649561026309, 5611.691356975365, 5685.9147112792925, 5715.828525144252, 5759.712014399263, 5764.394738552433, 6206.906896396557, 6235.532335074888, 6239.688015599202, 6263.0, 6292.1820163378925, 6609.93390066098, 6639.767608133692, 6660.766873159465, 6673.766418175341, 6692.63190524521, 6721.0, 6740.359665831738, 6794.796156115324, 6815.556988795713, 6817.69320380584, 6083.209182806251, 6192.225971753531, 6200.0, 6208.410201030895, 6334.2398912130375, 6832.350926661959, 6835.418989385858, 6848.417884479775, 6849.075374824434, 6864.073350097773, 6451.225852897683, 6532.08550802888, 6553.049807777941, 6558.573692710054, 6563.573367731177, 6632.1046658701425, 6662.600243985376, 6664.333566643394, 6672.86654266912, 6675.9332406676285, 6587.769428069994, 6595.241547222035, 6601.636909969901, 6649.002649602501, 6664.067030615718, 6677.799666010027, 6678.732850686015, 6692.297308782605, 6698.497612679069, 6783.118194634764, 5307.734613269321, 5317.574594032468, 5371.274877891435, 5391.083515802323, 5403.702796346239, 4581.037982023746, 4642.187617166982, 4655.674102812771, 4690.413698287714, 4727.149113159664, 5928.081147422156, 5964.31410387811, 5982.371850955674, 5983.042713165873, 5989.850253743604, 6759.188897332351, 6761.966190169018, 6834.794956151323, 6843.3840954314355, 6853.0, 5793.710314484259, 5876.08920617305, 5907.616004959664, 5998.280206375263, 6009.699515024231, 5738.655680659173, 5742.942570574324, 5751.741171647286, 5751.884962300731, 5754.971225143931, 6445.45213656835, 6535.836604084936, 6561.606303621894, 6571.934280657228, 6600.735970561123, 6657.3009833966735, 6715.697793599397, 6754.628495432602, 6783.966080169567, 6791.2190098139345, 6556.508261880283, 6592.17597800275, 6597.0, 6674.866502669823, 6684.0, 6500.0, 6533.705983230861, 6567.179102612174, 6600.735970561123, 6655.667216639245, 6781.491388146008, 6790.66046697673, 6802.387785099365, 6813.1142951415995, 6817.93182068173, 6431.099646049463, 6581.769638062645, 6595.076689263603, 6605.9009114864275, 6608.966955165193, 6494.772682956074, 6522.5760325578685, 6592.274849766618, 6595.703193356215, 6597.373249541286, 6352.682365881595, 6441.608016223361, 6443.291237963726, 6446.838829029124, 6552.8361790955605, 6306.779262725782, 6369.20384951881, 6379.202599675041, 6386.105945167587, 6387.520935929917, 6109.541784366102, 6196.194494715658, 6199.690015499117, 6345.175127233615, 6439.034144878306], "value": 6120.974285404934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.6652723011031, 810.5987536169597, 835.6949713354624, 838.3754103193119, 1114.8829372915848, 28892.711072889266, 29554.0, 38299.80850095746, 39357.0, 39684.60315396845, 39022.80488597553, 39406.21187576247, 39648.0, 39821.402678959836, 39861.80069099658, 7090.645467726619, 7469.925300746977, 7554.471187016911, 7650.311471967521, 7676.692932282702, 7576.469647124703, 7693.923060769376, 7704.114026886896, 7708.57602831844, 7710.1904300048245, 7663.885041724378, 7710.537367757953, 7716.382689384864, 7728.0, 7738.613069346538, 7582.696692132308, 7636.427267954898, 7688.615569221516, 7692.384609231248, 7696.846063078707, 7404.370628496585, 7551.660175292125, 7555.886661700079, 7576.090869095744, 7599.886001709923, 35311.470327944844, 35885.64114358849, 35944.82027589872, 36279.4558081629, 36287.27425451476, 3388.4409072503254, 3417.043227896193, 3422.401079811048, 3428.5200071989943, 3431.1765176357744, 29538.55692164619, 29556.113316600535, 29610.25974350637, 29696.703032969825, 29718.257043573867, 4812.663113582051, 5021.59827213822, 5034.295198672189, 5073.137566613685, 5074.391073071218, 183884.0, 184545.0, 185131.0, 186097.99999999863, 186707.0, 45323.54676453259, 45479.54520454753, 45572.31641525313, 45589.0, 45619.0, 47056.0, 47056.7647161762, 47183.764081179375, 47790.522094779306, 48672.7566362173, 13652.180869147884, 13761.449542018407, 13818.65453363674, 13824.930875345559, 13834.515791947233, 11105.666829995112, 11160.553577856796, 11255.831162532568, 12127.575534856238, 12341.62975110748, 12690.0, 12800.80798788019, 12838.486460541473, 12893.677658058623, 13064.608061758163, 5301.151815709468, 5393.325834270716, 5416.864578385572, 5507.614466987273, 5536.4186760389575, 937.9108984646448, 968.1963969904962, 968.6948611187454, 976.6923419123095, 989.4953573677476, 19250.80749192518, 19773.60452790936, 19813.0, 19890.204391824453, 20020.299289524795, 1064.5156453813652, 1072.860528131338, 1076.1283360478037, 1078.6548304542628, 1080.1143062688677, 10878.0, 10879.83680244797, 11023.283486573348, 11158.832617510743, 11190.0, 232432.0, 233754.0, 234875.0, 235072.0, 235554.0, 46318.305225421645, 46719.76640116778, 46784.0, 47088.5291147091, 47134.528654713016, 1392.0673148990202, 1416.8653977872086, 1422.6230049037013, 1424.181095869879, 1437.9640508987359, 18950.905245473685, 19202.90398548054, 19283.51791205231, 19603.509912252306, 19627.80372196317, 34590.82704586461, 34610.307793844484, 34667.826660866536, 34670.13324666904, 34682.0, 192135.0, 193399.0, 193629.0, 193997.0, 194229.0, 27350.179494615193, 27929.0, 27933.0, 30430.84784576063, 30743.231419213804, 40113.39829902496, 40147.59852401556, 40291.395629065, 40418.39372409475, 40547.59452405438, 29716.0, 30471.08586742401, 31885.043448696575, 32403.675963240064, 33141.834290829356, 31975.6802431982, 32371.35257294888, 32441.35117297688, 32644.83677581597, 32713.34573308568, 34683.47974780431, 35317.0, 35361.0, 35408.0, 35764.284714306086, 31214.687853122086, 31267.53098703476, 31351.21621959469, 31523.527147092354, 31846.840765796023, 23390.64914026325, 23914.88042559776, 23937.401564961016, 24072.03711851506, 24463.877680611484], "value": 16220.302928594447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8876224755047, 568.4230506036376, 571.191763654429, 572.8739677271, 572.9799457019005, 21095.15619375225, 21720.456988575275, 21756.673649895263, 21799.128034878624, 22864.0, 24080.75919240807, 24766.380840478952, 24771.876140619315, 24793.50412991739, 24808.131715389965, 6524.282328943812, 6640.0, 6656.733730650768, 6669.066330713704, 6677.532572719887, 5925.200097986782, 6165.475934545547, 6201.596896201732, 6522.804315870531, 6561.343865613424, 6147.692615369236, 6155.661438620874, 6156.415140561639, 6158.04550294705, 6165.352637973016, 6145.170401995718, 6145.661988590626, 6149.262088549381, 6150.354212807635, 6152.661603611799, 5725.112607545795, 5726.284214473191, 5732.914006289909, 5743.253377060997, 5744.368119506851, 28066.859665701744, 29026.85486572575, 29159.708402915912, 29540.704592954226, 29627.555586666003, 1970.8916009619466, 2005.8495612829097, 2013.395981205647, 2013.758348998115, 2015.304719871642, 18747.718784218247, 19540.31608893682, 19870.900645496826, 19872.70190947137, 19881.0059497026, 2446.902123915041, 2468.543319485901, 2503.5243303772227, 2509.4102885821817, 2514.107491840389, 130326.0, 133967.0, 134306.0, 135211.32394338064, 135225.0, 14207.928960355339, 14328.49850255236, 14453.554644535463, 14654.0, 15086.54740357791, 22671.093156273895, 22727.431814204447, 22733.09067637309, 22746.317610471713, 22868.771312286997, 9893.258005649604, 10011.899881001242, 10037.648682296085, 10101.393916365041, 10198.643047493302, 7999.680012799539, 9114.40756350835, 9150.908490915139, 9153.22197613197, 9248.630054797868, 7893.881591776128, 8755.868661970075, 8850.20348168668, 8863.568215892054, 9087.0, 2546.5416225079293, 2587.58598624223, 2596.4807038592357, 2632.1577095329694, 2653.6152257922495, 902.2962089570145, 937.4094320577992, 961.5769061612868, 966.0773960867355, 968.8934217236099, 18077.276908923497, 18219.180136893872, 18349.541261468305, 18840.0, 18924.148413321433, 1004.372267332917, 1008.5259927833906, 1011.145581983223, 1011.3325205364424, 1027.1423361493087, 10572.15422766177, 10677.199210059276, 10773.19201059908, 10833.783324333626, 10883.67348979532, 507369.0, 528929.0, 530755.0, 550795.0, 553516.0, 111150.44424777824, 119314.40342798231, 119410.0, 119995.0, 120701.99999999824, 1171.912106592009, 1179.1274456902001, 1216.2276954134188, 1221.6518292286833, 1222.7187746818104, 20509.0, 20829.583408331444, 20898.791012090292, 20961.0, 21241.575168496234, 58878.116828248465, 58992.0, 59411.70294148502, 59528.10707839299, 62286.68856655688, 69957.65021174861, 70765.0, 70954.0, 71080.28919710737, 71361.6431917837, 14200.28998550089, 14321.427142914166, 14737.778933316224, 14823.036502627294, 14827.555173344817, 22863.085476581415, 23073.423164420354, 23154.0, 23417.531649367258, 23647.763522364556, 17693.646127077645, 17852.19665115099, 17860.285588576313, 17959.281628735225, 18003.729944051112, 16152.19239038067, 16798.664026719154, 17080.82919170842, 17324.826751732322, 17411.216495258, 17771.289148433916, 17976.550586235448, 18026.729599056285, 18094.366697165537, 18097.819021809613, 14500.709985800437, 14622.488212912496, 14650.340734666752, 14651.780223296872, 14681.339339729951, 17825.10874456246, 17862.910685446488, 17953.73069403934, 17967.820321796615, 17992.820071799113], "value": 11842.270031918917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.3913043478262, 1281.205652495453, 1288.4524077267165, 1294.2428679222655, 1300.53830890034, 14265.358058887348, 14873.330700118508, 14878.628034299149, 14881.107133571966, 14886.106833589978, 12361.567345142921, 12784.616461506146, 14572.0, 15005.84994150058, 15022.924885375585, 2505.7619526144986, 2558.2069558436942, 2558.2325302409295, 2560.975609756103, 2562.1544890186287, 2536.315194897386, 2608.7652111309976, 2627.671541057368, 2635.2752992926908, 2729.7952653551065, 2718.4834881372476, 2755.2423083651956, 2763.392053748172, 2765.225736793691, 2767.501849667059, 2640.6171105189737, 2663.960040599383, 2671.3455203475078, 2673.6925253595696, 2696.973030269711, 2581.0, 2582.3156863431204, 2591.0, 2594.1828324077856, 2596.8701564921867, 14325.0, 14633.341499632543, 14634.268286585628, 14659.853401465956, 14661.41354345825, 7578.12851522071, 7838.764837054898, 7864.803379915491, 7865.567393793339, 7866.292033716935, 5089.480707050034, 5207.869803254911, 5262.473752624745, 5307.416184219733, 5373.946260537384, 1876.2776331112484, 1885.123417610804, 1892.7917929027797, 1934.3713293179633, 1938.9709154362695, 25461.236162915142, 25709.614355784677, 25751.35621609456, 25851.22446326613, 25863.0, 6466.1270728452, 6469.838254043687, 6606.933930660632, 6691.631960242136, 6712.798616041527, 16708.081055541817, 16734.665306693798, 16853.494395168163, 16890.74663880043, 16904.0, 7470.813229669193, 7702.768916932501, 7709.922900771033, 7716.4212684048925, 7718.498297610749, 7095.361417472453, 7152.0, 7224.566526008456, 7233.89149162763, 7240.746573869889, 5043.9747801260755, 5092.38891333035, 5193.870153246124, 5236.214567814858, 5248.370195576479, 1317.1701827848585, 1353.4180302469836, 1383.9169649821042, 1625.552972932453, 1670.9582260443342, 857.7083791510917, 878.1920633017639, 882.6469412235157, 889.6485888074175, 903.977400564978, 8196.959015204886, 8286.875696864552, 8347.332213422911, 8395.958020209982, 8446.662133514714, 945.1068740040596, 949.3070058856935, 950.2540505703129, 952.7189479103681, 963.2775418436173, 5135.537801597874, 5249.501297376743, 5329.0, 5392.649477783932, 5417.702026388586, 20471.0, 20735.688964665544, 20953.68569471459, 21146.154153833675, 21170.153193872073, 20553.79446205519, 20728.0, 20734.481637959172, 20794.792052079287, 20842.47893802637, 10894.346339219514, 10906.636670416197, 11183.664490065312, 11198.832017519744, 11212.887871121347, 8053.637586308513, 8172.6730930762105, 8188.467749596257, 8421.24208821209, 8959.596818143069, 17737.37919172823, 17795.19921603505, 18095.819041809413, 18225.5419566437, 18479.168437420616, 18159.273629055217, 18341.81658183401, 18437.446876593724, 18505.0, 18687.345942891934, 11859.762804744028, 11988.64034078979, 12059.81910271329, 12108.515659373526, 12122.212056216318, 13365.465381384636, 13546.0, 13719.176849389069, 13781.448742050607, 13797.620237976122, 11033.834492482458, 11068.335899846035, 11088.112950963743, 11171.329720216812, 11371.374574398156, 10483.528241229316, 10725.195610329101, 10859.402732849454, 10969.0, 11086.61196858106, 9160.816783664422, 9169.633214671605, 9265.629374824932, 9275.07249275067, 9306.022867598804, 6856.117259946196, 6926.896096558455, 7047.436205103477, 7087.3267039631155, 7125.18060423058, 7279.308465695751, 7357.22749111357, 7401.370883474965, 7452.552846829208, 7533.209013053551], "value": 6527.848477402521, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.98557043288713, 499.8625378021045, 509.55668568345544, 518.7121147762991, 521.7417378397694, 6254.43710066094, 6310.842228944273, 6322.778702745405, 6333.429991300782, 6406.903896441557, 6156.81529554113, 6162.7843025494, 6166.81499555014, 6214.3474935131835, 6268.529860260476, 5120.103981803179, 5122.8207012754565, 5160.67769503723, 5172.250023746555, 5216.408995256445, 4776.952230477703, 4994.575461085812, 5087.516685914832, 5168.741562921858, 5172.767225474862, 4898.8040478381, 4927.408710954691, 4954.157793175169, 4970.850874473772, 5012.122878496249, 4902.313676085351, 4926.162552366106, 4954.950450495521, 4996.400431948153, 4999.125328001999, 4370.8907277318, 4433.379326894237, 4439.711418757803, 4458.910821783546, 4460.710053846489, 6054.0, 6061.242344706911, 6080.348533371974, 6118.235220597426, 6201.472874805647, 5558.888822223574, 5663.1505274208785, 5688.772449102031, 5746.138079288098, 5755.568332375088, 6552.639604821733, 6589.439897608709, 6636.573136775568, 6640.501962352843, 6659.134312539339, 4851.151048566522, 4871.123197824426, 4913.115639184945, 4917.582005529534, 4928.556429921288, 6652.667366631746, 6672.931391268722, 6780.525363224576, 6826.522143449961, 6900.447964162905, 4903.117438860968, 4951.232558953368, 4969.503049695001, 4978.128827455181, 4982.626303027288, 5089.4147173074825, 5101.9489805101475, 5102.642815002914, 5107.846764597068, 5112.565431938253, 5760.452756988079, 5760.769569217268, 5766.135079738073, 5781.624194427349, 5790.189373487715, 6614.570052946639, 6623.304553021863, 6674.2658307586125, 6701.597904125768, 6727.428168605626, 1721.9655606887793, 1743.476956912921, 1751.9211635476433, 1753.0445906980726, 1753.4476639858403, 1172.8240763885315, 1210.9636710898687, 1224.7079331305558, 1227.975440491203, 1248.756492483957, 5922.940770592239, 5923.970380148072, 5933.554983376264, 5944.554158438048, 5966.31387390447, 6609.5373323867825, 6758.594484330956, 6768.593884366954, 6769.763058292936, 6782.74519213947, 5866.6480011199465, 5925.73334199962, 5950.196723442366, 5950.464458198783, 5970.283565972111, 3520.2607452435277, 3526.453399723047, 3552.1652411683235, 3557.928841423157, 3564.7167019872827, 6502.869942601122, 6528.053432252297, 6641.501887358468, 6667.366600172976, 6693.598384096969, 6862.382385585322, 6911.9308806912295, 6926.411255043377, 6946.687399067054, 7026.156861176692, 6554.082428460115, 6627.933720662828, 6654.301298363602, 6682.198136223587, 6740.0, 6709.865802683821, 6735.360140786617, 6802.3537763912345, 6833.692483838338, 6847.794566163023, 6614.834629134118, 6658.600483970978, 6712.53012289135, 6713.0, 6749.595024298558, 6624.205095388585, 6631.0, 6728.293529179561, 6733.326667333227, 6756.223034350916, 4967.230079337708, 4989.827390563142, 5017.774200161075, 5017.924731129109, 5050.0, 6522.771702990372, 6726.495512836459, 6771.289014653587, 6827.0, 6870.896936545856, 6194.690265486798, 6496.206631148462, 6578.901316480161, 6601.435224978458, 6629.303923088007, 6611.570247933869, 6634.838903192019, 6644.036614690939, 6659.600423974577, 6669.333066693292, 6431.163948686641, 6536.444402225864, 6538.411542961157, 6593.0, 6612.173478315211, 6702.966485167738, 6709.832254193684, 6713.395794378334, 6714.630695311805, 6736.888413411928, 6474.223093228843, 6474.676266186766, 6486.708098135501, 6497.707603157774, 6499.122618446449], "value": 5094.779500234356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.2696208223007, 880.2913654508119, 889.4440974391006, 899.8875140607424, 901.5492253873066, 17097.82902170978, 18007.459776206717, 21151.682724759143, 22376.664350034764, 22390.776092239073, 19523.429710867396, 20639.277625283117, 20783.064762085705, 20891.895540522313, 20926.26758063468, 923.5474617437441, 943.2831048403194, 948.7248697877607, 949.7768024514234, 950.0, 864.2653744317342, 948.3456415073612, 958.8417911044669, 964.4406244378279, 964.5129209749067, 987.4371608183338, 1000.2797985450501, 1000.4997501249376, 1001.3291094966354, 1001.3591301567003, 989.673407775436, 995.0397866059287, 995.5221493683073, 995.5967833027636, 997.8203923293804, 733.0104359115152, 736.0651971995536, 738.7045181927218, 738.7119023580753, 738.7414404958275, 19036.42890713281, 19386.4184074478, 19459.318923837738, 19645.607087858163, 19675.60648787016, 20809.479763006046, 20866.478338041517, 20910.686339704916, 21500.247491337883, 21546.56906861854, 16642.33430662772, 17029.744553831704, 17202.0, 17219.65560688779, 17230.138493075297, 3535.9469607955903, 3575.1598374382, 3590.1563132664064, 3591.4253719405033, 3604.819759012039, 126636.36681816624, 126690.0, 128963.0, 129063.0, 131159.0, 16087.919560402122, 16240.51278461648, 16272.105034222994, 16708.99746015243, 16760.329586816635, 26156.476870462866, 26168.8691556541, 26294.0, 26333.34166645849, 26335.34161645974, 7759.146493885668, 7849.607519623996, 7874.448788584744, 7875.803104922423, 7881.369490440751, 3982.74112182713, 4048.838046478108, 4076.286649836267, 4080.489938757655, 4080.5511393746665, 5103.464136265638, 5172.663776854492, 5199.986002729507, 5220.243064755665, 5224.164133738584, 926.6941909169958, 939.2579861909152, 955.3074021334477, 958.9520523973913, 959.0, 661.2659947458318, 672.7914346552584, 682.6791408038214, 686.498855835243, 693.3655705029842, 9776.706698799047, 9945.701628951143, 9972.80054398908, 10134.23993200513, 10698.62554810578, 644.5939058393183, 648.5816648261939, 654.1855390039432, 659.650385295794, 660.9900851487232, 4963.255511673206, 5021.372328458942, 5045.722485263345, 5059.494050594911, 5129.615278854101, 111528.0, 111581.0, 111693.32460013106, 112431.43784281026, 115206.0, 75433.83460897501, 94974.0, 97168.0, 101227.98772012333, 101358.0, 62753.68623156855, 88540.5572972131, 89297.55351223203, 90009.09990900138, 90853.0, 11741.706457338634, 11874.678377473641, 12026.15816892809, 12395.62813115608, 12504.062195335204, 39241.0, 40018.799906000284, 40073.79963100166, 41279.58720412877, 41352.0, 69173.30826691669, 70644.64677676579, 70666.29333706597, 70853.0, 72617.6369118151, 16511.587210319838, 16969.660606788042, 17104.828951710322, 17167.31330746756, 17219.65560688804, 17845.821541784935, 18491.0, 18543.258269669062, 18657.440276791716, 19412.0, 17582.472525824247, 17595.120243987494, 17814.198361073522, 17841.821581784017, 17917.820821791614, 18661.533461663566, 18943.33698320552, 18945.621087578445, 19137.330193443162, 19489.220431182595, 16295.51113466598, 17532.386366477112, 18092.366767163086, 18194.72707909409, 18317.3588924387, 13193.670158246121, 13513.797293040416, 13573.1856088635, 13698.657533561342, 13902.0, 12154.0, 12262.938685306874, 12596.622101336974, 12756.107072505207, 12993.480260789462], "value": 8838.899821692528, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 99.0, 113.0, 117.0, 109.0, 108.0, 113.0, 112.0, 116.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 144.0, 173.0, 122.0, 149.0, 145.0, 118.0, 169.0, 120.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 163.0, 163.0, 162.0, 163.0, 169.0, 169.0, 168.0, 171.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 169.0, 76.0, 74.0, 72.0, 78.0, 158.0, 75.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 133.0, 79.0, 79.0, 83.0, 130.0, 79.0, 78.0, 132.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 122.0, 117.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 148.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 94.0, 96.0, 98.0, 99.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 52.0, 52.0, 52.0, 57.0, 55.0, 51.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 62.0, 59.0, 55.0, 59.0, 56.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 74.0, 76.0, 80.0, 86.0, 81.0, 78.0, 75.0, 76.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 119.0, 122.0, 125.0, 123.0, 124.0, 119.0, 117.0, 121.0, 155.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 176.0, 179.0, 169.0, 177.0, 168.0, 178.0, 169.0, 174.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 75.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 65.6, "unit": "score"}]}]} 08:19:09 INFO - Return code: 0 08:19:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:09 INFO - # TBPL SUCCESS # 08:19:09 INFO - Running post-action listener: _package_coverage_data 08:19:09 INFO - Running post-action listener: _resource_record_post_action 08:19:09 INFO - [mozharness: 2017-08-25 15:19:09.868610Z] Finished run-tests step (success) 08:19:09 INFO - Running post-run listener: _resource_record_post_run 08:19:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 428163072; Read time: 8; Write time: 229280 08:19:09 INFO - TinderboxPrint: CPU usage
13.1% 08:19:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:19:09 INFO - TinderboxPrint: I/O write bytes / time
428,163,072 / 229,280 08:19:09 INFO - TinderboxPrint: CPU idle
8,263.4 (86.9%) 08:19:09 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 08:19:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:19:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105275392; Read time: 0; Write time: 70248 08:19:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:19:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322273280; Read time: 8; Write time: 159032 08:19:10 INFO - Running post-run listener: _upload_blobber_files 08:19:10 INFO - Blob upload gear active. 08:19:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:10 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 08:19:10 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'] 08:19:10 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 08:19:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:19:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:11 INFO - (blobuploader) - INFO - Done attempting. 08:19:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:19:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:12 INFO - (blobuploader) - INFO - Done attempting. 08:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:20 INFO - (blobuploader) - INFO - Done attempting. 08:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:19:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:19:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:21 INFO - (blobuploader) - INFO - Done attempting. 08:19:21 INFO - (blobuploader) - INFO - Iteration through files over. 08:19:21 INFO - Return code: 0 08:19:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:19:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:19:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b037d48ced2dcb48c4a556094dbff3a3fa6e565f7244cec9f9919c6900f627087dade3f86067bd93b6b987efd408af12b4d96e6e54934b4d3134a919c7cdd58", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0279aa347536d6d499927fcb24590538fd15335f688cbd1c7bc2713dd7d66ff6ebd7fe304a42159ec34afff110da9b6f8ae20273a20026da54bbc549df3c4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8c2a9e234c030eaebee2d9b011b39146d7bee5ddbd126d047d34241740987e0997a1e3ac6fd64b77393abb61e2557e5c5f9fb40ddb07d7061396ac41cdae56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/129bc7eb8da07895d0486ec542250124edb2b0b17d2bc810284d5e85b78f9f965e340cbe2a2c0e9fcc8aeea2b6c47872301c5b1ad1b12d96ee228b1b40fc21b2"} 08:19:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:19:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:19:21 INFO - Contents: 08:19:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b037d48ced2dcb48c4a556094dbff3a3fa6e565f7244cec9f9919c6900f627087dade3f86067bd93b6b987efd408af12b4d96e6e54934b4d3134a919c7cdd58", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0279aa347536d6d499927fcb24590538fd15335f688cbd1c7bc2713dd7d66ff6ebd7fe304a42159ec34afff110da9b6f8ae20273a20026da54bbc549df3c4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8c2a9e234c030eaebee2d9b011b39146d7bee5ddbd126d047d34241740987e0997a1e3ac6fd64b77393abb61e2557e5c5f9fb40ddb07d7061396ac41cdae56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/129bc7eb8da07895d0486ec542250124edb2b0b17d2bc810284d5e85b78f9f965e340cbe2a2c0e9fcc8aeea2b6c47872301c5b1ad1b12d96ee228b1b40fc21b2"} 08:19:21 INFO - Running post-run listener: copy_logs_to_upload_dir 08:19:21 INFO - Copying logs to upload dir... 08:19:21 INFO - mkdir: /builds/slave/test/build/upload/logs 08:19:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.430735 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-25 08:19:21.152063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 08:19:21.157046) ========= 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=483e410453545d07cca6935c000001ab-1503668027.538621-853868537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b037d48ced2dcb48c4a556094dbff3a3fa6e565f7244cec9f9919c6900f627087dade3f86067bd93b6b987efd408af12b4d96e6e54934b4d3134a919c7cdd58", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0279aa347536d6d499927fcb24590538fd15335f688cbd1c7bc2713dd7d66ff6ebd7fe304a42159ec34afff110da9b6f8ae20273a20026da54bbc549df3c4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8c2a9e234c030eaebee2d9b011b39146d7bee5ddbd126d047d34241740987e0997a1e3ac6fd64b77393abb61e2557e5c5f9fb40ddb07d7061396ac41cdae56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/129bc7eb8da07895d0486ec542250124edb2b0b17d2bc810284d5e85b78f9f965e340cbe2a2c0e9fcc8aeea2b6c47872301c5b1ad1b12d96ee228b1b40fc21b2"} build_url:https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/Ehja7yuaStWOcBSW8mDwsA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b037d48ced2dcb48c4a556094dbff3a3fa6e565f7244cec9f9919c6900f627087dade3f86067bd93b6b987efd408af12b4d96e6e54934b4d3134a919c7cdd58", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a0279aa347536d6d499927fcb24590538fd15335f688cbd1c7bc2713dd7d66ff6ebd7fe304a42159ec34afff110da9b6f8ae20273a20026da54bbc549df3c4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e8c2a9e234c030eaebee2d9b011b39146d7bee5ddbd126d047d34241740987e0997a1e3ac6fd64b77393abb61e2557e5c5f9fb40ddb07d7061396ac41cdae56", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/129bc7eb8da07895d0486ec542250124edb2b0b17d2bc810284d5e85b78f9f965e340cbe2a2c0e9fcc8aeea2b6c47872301c5b1ad1b12d96ee228b1b40fc21b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-25 08:19:21.187761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 08:19:21.188516) ========= 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=483e410453545d07cca6935c000001ab-1503668027.538621-853868537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-25 08:19:21.271749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 08:19:21.272453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-25 08:19:21.273073) ========= ========= Total master_lag: 0.21 =========