builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1504376121.63 results: success (0) revision: 59611e1583e7411bab615d29109894e4c657af33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.627117) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.627543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.627811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.645339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.645637) ========= 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=1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-02 11:15:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-09-02 11:15:22 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135217 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.812923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.813194) ========= 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=1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016263 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.871243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.871650) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 59611e1583e7411bab615d29109894e4c657af33 --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 59611e1583e7411bab615d29109894e4c657af33 --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=1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-02 11:15:22,262 truncating revision to first 12 chars 2017-09-02 11:15:22,262 Setting DEBUG logging. 2017-09-02 11:15:22,262 attempt 1/10 2017-09-02 11:15:22,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/59611e1583e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-02 11:15:22,850 unpacking tar archive at: mozilla-central-59611e1583e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968014 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.859357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.862645) ========= script_repo_revision: 59611e1583e7411bab615d29109894e4c657af33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.862993) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.863248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.876694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-02 11:15:22.876985) ========= /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=1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:15:23 INFO - MultiFileLogger online at 20170902 11:15:23 in /builds/slave/test 11:15:23 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 11:15:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:23 INFO - {'append_to_log': False, 11:15:23 INFO - 'base_work_dir': '/builds/slave/test', 11:15:23 INFO - 'blob_upload_branch': 'Firefox', 11:15:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:23 INFO - 'branch': 'Firefox', 11:15:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:23 INFO - 'code_coverage': False, 11:15:23 INFO - 'config_files': ('talos/linux_config.py',), 11:15:23 INFO - 'default_actions': ('clobber', 11:15:23 INFO - 'read-buildbot-config', 11:15:23 INFO - 'download-and-extract', 11:15:23 INFO - 'populate-webroot', 11:15:23 INFO - 'create-virtualenv', 11:15:23 INFO - 'install', 11:15:23 INFO - 'setup-mitmproxy', 11:15:23 INFO - 'run-tests'), 11:15:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:23 INFO - 'disable_ccov_upload': False, 11:15:23 INFO - 'disable_stylo': False, 11:15:23 INFO - 'download_minidump_stackwalk': True, 11:15:23 INFO - 'download_symbols': 'ondemand', 11:15:23 INFO - 'enable_stylo': False, 11:15:23 INFO - 'enable_webrender': False, 11:15:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:15:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:23 INFO - 'gecko_profile': False, 11:15:23 INFO - 'gecko_profile_interval': 0, 11:15:23 INFO - 'installer_path': 'installer.exe', 11:15:23 INFO - 'log_level': 'info', 11:15:23 INFO - 'log_name': 'talos', 11:15:23 INFO - 'log_to_console': True, 11:15:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:15:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:15:23 INFO - 'opt_config_files': (), 11:15:23 INFO - 'pip_index': False, 11:15:23 INFO - 'suite': 'dromaeojs-e10s', 11:15:23 INFO - 'system_bits': '32', 11:15:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:23 INFO - 'title': 'talos-linux64-ix-027', 11:15:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:23 INFO - 'use_talos_json': True, 11:15:23 INFO - 'verify': 'False', 11:15:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:23 INFO - 'work_dir': 'build'} 11:15:23 INFO - [mozharness: 2017-09-02 18:15:23.408417Z] Running clobber step. 11:15:23 INFO - Running pre-action listener: _resource_record_pre_action 11:15:23 INFO - Running main action method: clobber 11:15:23 INFO - rmtree: /builds/slave/test/build 11:15:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:24 INFO - Running post-action listener: _resource_record_post_action 11:15:24 INFO - [mozharness: 2017-09-02 18:15:24.429451Z] Finished clobber step (success) 11:15:24 INFO - [mozharness: 2017-09-02 18:15:24.429549Z] Running read-buildbot-config step. 11:15:24 INFO - Running pre-action listener: _resource_record_pre_action 11:15:24 INFO - Running main action method: read_buildbot_config 11:15:24 INFO - Using buildbot properties: 11:15:24 INFO - { 11:15:24 INFO - "project": "", 11:15:24 INFO - "product": "firefox", 11:15:24 INFO - "who": "ffxbld@noreply.mozilla.org", 11:15:24 INFO - "installer_path": "public/build/target.tar.bz2", 11:15:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:15:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:15:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:15:24 INFO - "stage_platform": "linux64-stylosequential", 11:15:24 INFO - "basedir": "/builds/slave/test", 11:15:24 INFO - "buildnumber": 184, 11:15:24 INFO - "platform": "ubuntu64_hw_styloseq", 11:15:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:15:24 INFO - "slavebuilddir": "test", 11:15:24 INFO - "taskId": "SJptoqEqQ3WayDyO-1cbKw", 11:15:24 INFO - "branch": "mozilla-central", 11:15:24 INFO - "script_repo_revision": "production", 11:15:24 INFO - "revision": "59611e1583e7411bab615d29109894e4c657af33", 11:15:24 INFO - "slavename": "talos-linux64-ix-027", 11:15:24 INFO - "repo_path": "mozilla-central" 11:15:24 INFO - } 11:15:24 INFO - Finding installer, test and symbols from parent task. 11:15:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJptoqEqQ3WayDyO-1cbKw'}, attempt #1 11:15:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJptoqEqQ3WayDyO-1cbKw'}, attempt #1 11:15:25 INFO - Task dependencies: C-9NEaTqQja8SGXabZPikw 11:15:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw'}, attempt #1 11:15:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json 11:15:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip 11:15:25 INFO - Running post-action listener: _resource_record_post_action 11:15:25 INFO - [mozharness: 2017-09-02 18:15:25.798637Z] Finished read-buildbot-config step (success) 11:15:25 INFO - [mozharness: 2017-09-02 18:15:25.798855Z] Running download-and-extract step. 11:15:25 INFO - Running pre-action listener: _resource_record_pre_action 11:15:25 INFO - Running main action method: download_and_extract 11:15:25 INFO - mkdir: /builds/slave/test/build/tests 11:15:25 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')]} 11:15:25 INFO - trying https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json 11:15:25 INFO - Downloading https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:15:26 INFO - Downloaded 989 bytes. 11:15:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:15:26 INFO - Using the following test package requirements: 11:15:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:15:26 INFO - u'common': [u'target.common.tests.zip'], 11:15:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:15:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:15:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:15:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:15:26 INFO - u'mozbase': [u'target.common.tests.zip'], 11:15:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:15:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:15:26 INFO - u'web-platform': [u'target.common.tests.zip', 11:15:26 INFO - u'target.web-platform.tests.tar.gz'], 11:15:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:15:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:15:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip 11:15:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:15:26 INFO - Fetch https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip into memory 11:15:27 INFO - Content-Length response header: 55022419 11:15:27 INFO - Bytes received: 55022419 11:15:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:15:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip 11:15:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:15:38 INFO - Fetch https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip into memory 11:15:39 INFO - Content-Length response header: 55022419 11:15:39 INFO - Bytes received: 55022419 11:15:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.talos.tests.zip 11:15:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:15:51 INFO - Fetch https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.talos.tests.zip into memory 11:15:52 INFO - Content-Length response header: 14496650 11:15:52 INFO - Bytes received: 14496650 11:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:52 INFO - trying https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:52 INFO - Downloading https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:15:53 INFO - Downloaded 62714781 bytes. 11:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:53 INFO - mkdir: /builds/slave/test/properties 11:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:53 INFO - Contents: 11:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:53 INFO - Running post-action listener: _resource_record_post_action 11:15:53 INFO - Running post-action listener: find_tests_for_verification 11:15:53 INFO - Running post-action listener: set_extra_try_arguments 11:15:53 INFO - [mozharness: 2017-09-02 18:15:53.428273Z] Finished download-and-extract step (success) 11:15:53 INFO - [mozharness: 2017-09-02 18:15:53.428370Z] Running populate-webroot step. 11:15:53 INFO - Running pre-action listener: _resource_record_pre_action 11:15:53 INFO - Running main action method: populate_webroot 11:15:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:53 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:53 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:53 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'tests': ['damp', 'tps']}, 11:15:53 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['damp', 'tps']}, 11:15:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:15:53 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:15:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:53 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:53 INFO - 'ts_paint', 11:15:53 INFO - 'tpaint', 11:15:53 INFO - 'sessionrestore', 11:15:53 INFO - 'sessionrestore_many_windows', 11:15:53 INFO - 'sessionrestore_no_auto_restore', 11:15:53 INFO - 'tabpaint']}, 11:15:53 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['a11yr', 11:15:53 INFO - 'ts_paint', 11:15:53 INFO - 'tpaint', 11:15:53 INFO - 'sessionrestore', 11:15:53 INFO - 'sessionrestore_many_windows', 11:15:53 INFO - 'sessionrestore_no_auto_restore', 11:15:53 INFO - 'tabpaint']}, 11:15:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:15:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:15:53 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['bloom_basic_singleton']}, 11:15:53 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['bloom_basic']}, 11:15:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:53 INFO - 'tsvgr_opacity', 11:15:53 INFO - 'tart', 11:15:53 INFO - 'tscrollx', 11:15:53 INFO - 'tsvg_static']}, 11:15:53 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['tsvgx', 11:15:53 INFO - 'tsvgr_opacity', 11:15:53 INFO - 'tart', 11:15:53 INFO - 'tscrollx', 11:15:53 INFO - 'tsvg_static']}, 11:15:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:15:53 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo'], 11:15:53 INFO - 'tests': ['tp5o']}, 11:15:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:53 INFO - 'talos_options': ['--mitmproxy', 11:15:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:53 INFO - '--firstNonBlankPaint'], 11:15:53 INFO - 'tests': ['tp6_google', 11:15:53 INFO - 'tp6_youtube', 11:15:53 INFO - 'tp6_amazon', 11:15:53 INFO - 'tp6_facebook']}, 11:15:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo', 11:15:53 INFO - '--mitmproxy', 11:15:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:53 INFO - '--firstNonBlankPaint'], 11:15:53 INFO - 'tests': ['tp6_google', 11:15:53 INFO - 'tp6_youtube', 11:15:53 INFO - 'tp6_amazon', 11:15:53 INFO - 'tp6_facebook']}, 11:15:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo', 11:15:53 INFO - '--stylo-threads=1', 11:15:53 INFO - '--mitmproxy', 11:15:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:53 INFO - '--firstNonBlankPaint'], 11:15:53 INFO - 'tests': ['tp6_google', 11:15:53 INFO - 'tp6_youtube', 11:15:53 INFO - 'tp6_amazon', 11:15:53 INFO - 'tp6_facebook']}, 11:15:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'talos_options': ['--xperf_path', 11:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:53 INFO - 'tests': ['tp5n']}, 11:15:53 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:53 INFO - 'talos_options': ['--enable-stylo', 11:15:53 INFO - '--xperf_path', 11:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:53 INFO - 'tests': ['tp5n']}}} 11:15:53 INFO - Running post-action listener: _resource_record_post_action 11:15:53 INFO - [mozharness: 2017-09-02 18:15:53.442627Z] Finished populate-webroot step (success) 11:15:53 INFO - [mozharness: 2017-09-02 18:15:53.442716Z] Running create-virtualenv step. 11:15:53 INFO - Running pre-action listener: _resource_record_pre_action 11:15:53 INFO - Running main action method: create_virtualenv 11:15:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:53 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:53 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:15:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:15:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:54 INFO - Installing pip...............done. 11:15:54 INFO - Return code: 0 11:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:15:54 INFO - Reading from file tmpfile_stdout 11:15:54 INFO - Output received: 11:15:54 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:15:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:54 INFO - Using env: {'DISPLAY': ':0', 11:15:54 INFO - 'HOME': '/home/cltbld', 11:15:54 INFO - 'LANG': 'en_US.UTF-8', 11:15:54 INFO - 'LANGUAGE': 'en_US:en', 11:15:54 INFO - 'LOGNAME': 'cltbld', 11:15:54 INFO - 'MAIL': '/var/mail/cltbld', 11:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:54 INFO - 'MOZ_NO_REMOTE': '1', 11:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:54 INFO - 'NO_EM_RESTART': '1', 11:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:54 INFO - 'PWD': '/builds/slave/test', 11:15:54 INFO - 'SHELL': '/bin/bash', 11:15:54 INFO - 'SHLVL': '1', 11:15:54 INFO - 'TERM': 'linux', 11:15:54 INFO - 'TMOUT': '86400', 11:15:54 INFO - 'USER': 'cltbld', 11:15:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:54 INFO - '_': '/tools/buildbot/bin/python'} 11:15:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:15:55 INFO - Downloading/unpacking pip>=1.5 11:15:55 INFO - Running setup.py egg_info for package pip 11:15:55 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:55 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:55 INFO - Installing collected packages: pip 11:15:55 INFO - Found existing installation: pip 1.1 11:15:55 INFO - Uninstalling pip: 11:15:55 INFO - Successfully uninstalled pip 11:15:55 INFO - Running setup.py install for pip 11:15:55 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:55 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:15:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:15:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:15:55 INFO - Successfully installed pip 11:15:55 INFO - Cleaning up... 11:15:55 INFO - Return code: 0 11:15:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:55 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')]} 11:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:55 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')]} 11:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:55 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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:15:55 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 11:15:55 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 11:15:55 INFO - Using env: {'DISPLAY': ':0', 11:15:55 INFO - 'HOME': '/home/cltbld', 11:15:55 INFO - 'LANG': 'en_US.UTF-8', 11:15:55 INFO - 'LANGUAGE': 'en_US:en', 11:15:55 INFO - 'LOGNAME': 'cltbld', 11:15:55 INFO - 'MAIL': '/var/mail/cltbld', 11:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:55 INFO - 'MOZ_NO_REMOTE': '1', 11:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:55 INFO - 'NO_EM_RESTART': '1', 11:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:55 INFO - 'PWD': '/builds/slave/test', 11:15:55 INFO - 'SHELL': '/bin/bash', 11:15:55 INFO - 'SHLVL': '1', 11:15:55 INFO - 'TERM': 'linux', 11:15:55 INFO - 'TMOUT': '86400', 11:15:55 INFO - 'USER': 'cltbld', 11:15:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:55 INFO - '_': '/tools/buildbot/bin/python'} 11:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:55 INFO - Downloading/unpacking psutil>=3.1.1 11:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:57 INFO - Installing collected packages: psutil 11:15:57 INFO - Running setup.py install for psutil 11:15:57 INFO - building 'psutil._psutil_linux' extension 11:15:57 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 11:15:57 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 11:15:57 INFO - building 'psutil._psutil_posix' extension 11:15:57 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 11:15:57 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 11:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:57 INFO - Successfully installed psutil 11:15:57 INFO - Cleaning up... 11:15:57 INFO - Return code: 0 11:15:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15: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')]} 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15: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')]} 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:15: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 mozsystemmonitor==0.3 11:15:57 INFO - Using env: {'DISPLAY': ':0', 11:15:57 INFO - 'HOME': '/home/cltbld', 11:15:57 INFO - 'LANG': 'en_US.UTF-8', 11:15:57 INFO - 'LANGUAGE': 'en_US:en', 11:15:57 INFO - 'LOGNAME': 'cltbld', 11:15:57 INFO - 'MAIL': '/var/mail/cltbld', 11:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:57 INFO - 'MOZ_NO_REMOTE': '1', 11:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:57 INFO - 'NO_EM_RESTART': '1', 11:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:57 INFO - 'PWD': '/builds/slave/test', 11:15:57 INFO - 'SHELL': '/bin/bash', 11:15:57 INFO - 'SHLVL': '1', 11:15:57 INFO - 'TERM': 'linux', 11:15:57 INFO - 'TMOUT': '86400', 11:15:57 INFO - 'USER': 'cltbld', 11:15:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:57 INFO - '_': '/tools/buildbot/bin/python'} 11:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:58 INFO - Installing collected packages: mozsystemmonitor 11:15:58 INFO - Running setup.py install for mozsystemmonitor 11:15:59 INFO - Successfully installed mozsystemmonitor 11:15:59 INFO - Cleaning up... 11:15:59 INFO - Return code: 0 11:15:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:15:59 INFO - Using env: {'DISPLAY': ':0', 11:15:59 INFO - 'HOME': '/home/cltbld', 11:15:59 INFO - 'LANG': 'en_US.UTF-8', 11:15:59 INFO - 'LANGUAGE': 'en_US:en', 11:15:59 INFO - 'LOGNAME': 'cltbld', 11:15:59 INFO - 'MAIL': '/var/mail/cltbld', 11:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:59 INFO - 'MOZ_NO_REMOTE': '1', 11:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:59 INFO - 'NO_EM_RESTART': '1', 11:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:59 INFO - 'PWD': '/builds/slave/test', 11:15:59 INFO - 'SHELL': '/bin/bash', 11:15:59 INFO - 'SHLVL': '1', 11:15:59 INFO - 'TERM': 'linux', 11:15:59 INFO - 'TMOUT': '86400', 11:15:59 INFO - 'USER': 'cltbld', 11:15:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:59 INFO - '_': '/tools/buildbot/bin/python'} 11:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:59 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16: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 11:16: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 11:16: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 11:16: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 11:16:00 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:00 INFO - warning: no files found matching '*.txt' 11:16:00 INFO - no previously-included directories found matching 'build' 11:16:00 INFO - no previously-included directories found matching 'dist' 11:16:00 INFO - no previously-included directories found matching '.git*' 11:16:00 INFO - Installing collected packages: jsonschema, functools32 11:16:00 INFO - Running setup.py install for functools32 11:16:00 INFO - warning: no files found matching '*.txt' 11:16:00 INFO - no previously-included directories found matching 'build' 11:16:00 INFO - no previously-included directories found matching 'dist' 11:16:00 INFO - no previously-included directories found matching '.git*' 11:16:00 INFO - Successfully installed jsonschema functools32 11:16:00 INFO - Cleaning up... 11:16:00 INFO - Return code: 0 11:16:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16: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')]} 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16: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', '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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:16: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:16: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 functools32==3.2.3-2 11:16:00 INFO - Using env: {'DISPLAY': ':0', 11:16:00 INFO - 'HOME': '/home/cltbld', 11:16:00 INFO - 'LANG': 'en_US.UTF-8', 11:16:00 INFO - 'LANGUAGE': 'en_US:en', 11:16:00 INFO - 'LOGNAME': 'cltbld', 11:16:00 INFO - 'MAIL': '/var/mail/cltbld', 11:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:00 INFO - 'MOZ_NO_REMOTE': '1', 11:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:00 INFO - 'NO_EM_RESTART': '1', 11:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:00 INFO - 'PWD': '/builds/slave/test', 11:16:00 INFO - 'SHELL': '/bin/bash', 11:16:00 INFO - 'SHLVL': '1', 11:16:00 INFO - 'TERM': 'linux', 11:16:00 INFO - 'TMOUT': '86400', 11:16:00 INFO - 'USER': 'cltbld', 11:16:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:00 INFO - '_': '/tools/buildbot/bin/python'} 11:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:16:00 INFO - Cleaning up... 11:16:00 INFO - Return code: 0 11:16:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16: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')]} 11:16:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16: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', '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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:16: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:16: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 blobuploader==1.2.4 11:16:00 INFO - Using env: {'DISPLAY': ':0', 11:16:00 INFO - 'HOME': '/home/cltbld', 11:16:00 INFO - 'LANG': 'en_US.UTF-8', 11:16:00 INFO - 'LANGUAGE': 'en_US:en', 11:16:00 INFO - 'LOGNAME': 'cltbld', 11:16:00 INFO - 'MAIL': '/var/mail/cltbld', 11:16:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:00 INFO - 'MOZ_NO_REMOTE': '1', 11:16:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:00 INFO - 'NO_EM_RESTART': '1', 11:16:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:00 INFO - 'PWD': '/builds/slave/test', 11:16:00 INFO - 'SHELL': '/bin/bash', 11:16:00 INFO - 'SHLVL': '1', 11:16:00 INFO - 'TERM': 'linux', 11:16:00 INFO - 'TMOUT': '86400', 11:16:00 INFO - 'USER': 'cltbld', 11:16:00 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:00 INFO - '_': '/tools/buildbot/bin/python'} 11:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:01 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:02 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 11:16:02 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 11:16:02 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 11:16:02 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 11:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:02 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 11:16:02 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 11:16:02 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 11:16:02 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 11:16:02 INFO - Downloading docopt-0.6.1.tar.gz 11:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:02 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:02 INFO - Running setup.py install for blobuploader 11:16:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:02 INFO - Running setup.py install for requests 11:16:03 INFO - Running setup.py install for docopt 11:16:03 INFO - Successfully installed blobuploader requests docopt 11:16:03 INFO - Cleaning up... 11:16:03 INFO - Return code: 0 11:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:03 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')]} 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:03 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')]} 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:03 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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:16:03 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 11:16:03 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 11:16:03 INFO - Using env: {'DISPLAY': ':0', 11:16:03 INFO - 'HOME': '/home/cltbld', 11:16:03 INFO - 'LANG': 'en_US.UTF-8', 11:16:03 INFO - 'LANGUAGE': 'en_US:en', 11:16:03 INFO - 'LOGNAME': 'cltbld', 11:16:03 INFO - 'MAIL': '/var/mail/cltbld', 11:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:03 INFO - 'MOZ_NO_REMOTE': '1', 11:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:03 INFO - 'NO_EM_RESTART': '1', 11:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:03 INFO - 'PWD': '/builds/slave/test', 11:16:03 INFO - 'SHELL': '/bin/bash', 11:16:03 INFO - 'SHLVL': '1', 11:16:03 INFO - 'TERM': 'linux', 11:16:03 INFO - 'TMOUT': '86400', 11:16:03 INFO - 'USER': 'cltbld', 11:16:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:03 INFO - '_': '/tools/buildbot/bin/python'} 11:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:03 INFO - Running setup.py (path:/tmp/pip-bw6xk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:03 INFO - Running setup.py (path:/tmp/pip-vaU8RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:03 INFO - Running setup.py (path:/tmp/pip-LtdHdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:03 INFO - Running setup.py (path:/tmp/pip-yHl5IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:03 INFO - Running setup.py (path:/tmp/pip-x8qIaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:04 INFO - Running setup.py (path:/tmp/pip-1SLZcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:04 INFO - Running setup.py (path:/tmp/pip-ONbW7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:04 INFO - Running setup.py (path:/tmp/pip-UMTJwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:04 INFO - Running setup.py (path:/tmp/pip-m7lynv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:04 INFO - Running setup.py (path:/tmp/pip-hcbKDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:04 INFO - Running setup.py (path:/tmp/pip-A6uFSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:04 INFO - Running setup.py (path:/tmp/pip-fe6aou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:04 INFO - Running setup.py (path:/tmp/pip-3ng_lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:04 INFO - Running setup.py (path:/tmp/pip-CiIy8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:04 INFO - Running setup.py (path:/tmp/pip-U9tx6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:04 INFO - Running setup.py (path:/tmp/pip-ZMfsUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:04 INFO - Running setup.py (path:/tmp/pip-RUZJho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:04 INFO - Running setup.py install for manifestparser 11:16:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:04 INFO - Running setup.py install for mozcrash 11:16:05 INFO - Running setup.py install for mozdebug 11:16:05 INFO - Running setup.py install for mozdevice 11:16:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Running setup.py install for mozfile 11:16:05 INFO - Running setup.py install for mozhttpd 11:16:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Running setup.py install for mozinfo 11:16:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Running setup.py install for mozInstall 11:16:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Running setup.py install for mozleak 11:16:05 INFO - Running setup.py install for mozlog 11:16:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Running setup.py install for moznetwork 11:16:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:05 INFO - Running setup.py install for mozprocess 11:16:06 INFO - Running setup.py install for mozprofile 11:16:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:06 INFO - Running setup.py install for mozrunner 11:16:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:06 INFO - Running setup.py install for mozscreenshot 11:16:06 INFO - Running setup.py install for moztest 11:16:06 INFO - Running setup.py install for mozversion 11:16:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:06 INFO - Cleaning up... 11:16:06 INFO - Return code: 0 11:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:06 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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:16:06 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 11:16:06 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 11:16:06 INFO - Using env: {'DISPLAY': ':0', 11:16:06 INFO - 'HOME': '/home/cltbld', 11:16:06 INFO - 'LANG': 'en_US.UTF-8', 11:16:06 INFO - 'LANGUAGE': 'en_US:en', 11:16:06 INFO - 'LOGNAME': 'cltbld', 11:16:06 INFO - 'MAIL': '/var/mail/cltbld', 11:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:06 INFO - 'MOZ_NO_REMOTE': '1', 11:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:06 INFO - 'NO_EM_RESTART': '1', 11:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:06 INFO - 'PWD': '/builds/slave/test', 11:16:06 INFO - 'SHELL': '/bin/bash', 11:16:06 INFO - 'SHLVL': '1', 11:16:06 INFO - 'TERM': 'linux', 11:16:06 INFO - 'TMOUT': '86400', 11:16:06 INFO - 'USER': 'cltbld', 11:16:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:06 INFO - '_': '/tools/buildbot/bin/python'} 11:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:06 INFO - Running setup.py (path:/tmp/pip-Lpw35D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:06 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)) 11:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:06 INFO - Running setup.py (path:/tmp/pip-AruvR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:06 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)) 11:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:06 INFO - Running setup.py (path:/tmp/pip-NOamXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:07 INFO - Running setup.py (path:/tmp/pip-jpLbVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:07 INFO - Running setup.py (path:/tmp/pip-2M2Qht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:07 INFO - Running setup.py (path:/tmp/pip-qUj2DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:07 INFO - Running setup.py (path:/tmp/pip-CoYuVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:07 INFO - Running setup.py (path:/tmp/pip-1Uucxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:07 INFO - Running setup.py (path:/tmp/pip-jIk0NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:07 INFO - Running setup.py (path:/tmp/pip-mdYTHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:07 INFO - Running setup.py (path:/tmp/pip-0c8Luk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:07 INFO - Running setup.py (path:/tmp/pip-f7VcxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:07 INFO - Running setup.py (path:/tmp/pip-H5G4MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:07 INFO - Running setup.py (path:/tmp/pip-2iQBdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:07 INFO - Running setup.py (path:/tmp/pip-gI2n7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:07 INFO - Running setup.py (path:/tmp/pip-mCzo4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:07 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)) 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:07 INFO - Running setup.py (path:/tmp/pip-J6PAg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:08 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)) 11:16:08 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)) 11:16:08 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)) 11:16:08 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)) 11:16:08 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)) 11:16:08 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)) 11:16:08 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)) 11:16:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:09 INFO - Downloading blessings-1.6.tar.gz 11:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:09 INFO - Installing collected packages: blessings 11:16:09 INFO - Running setup.py install for blessings 11:16:09 INFO - Successfully installed blessings 11:16:09 INFO - Cleaning up... 11:16:09 INFO - Return code: 0 11:16:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:09 INFO - Reading from file tmpfile_stdout 11:16:09 INFO - Current package versions: 11:16:09 INFO - argparse == 1.2.1 11:16:09 INFO - blessings == 1.6 11:16:09 INFO - blobuploader == 1.2.4 11:16:09 INFO - docopt == 0.6.1 11:16:09 INFO - functools32 == 3.2.3-2 11:16:09 INFO - jsonschema == 2.5.1 11:16:09 INFO - manifestparser == 1.1 11:16:09 INFO - mozInstall == 1.13 11:16:09 INFO - mozcrash == 1.0 11:16:09 INFO - mozdebug == 0.1 11:16:09 INFO - mozdevice == 0.51 11:16:09 INFO - mozfile == 1.2 11:16:09 INFO - mozhttpd == 0.7 11:16:09 INFO - mozinfo == 0.10 11:16:09 INFO - mozleak == 0.1 11:16:09 INFO - mozlog == 3.5 11:16:09 INFO - moznetwork == 0.27 11:16:09 INFO - mozprocess == 0.25 11:16:09 INFO - mozprofile == 0.28 11:16:09 INFO - mozrunner == 6.13 11:16:09 INFO - mozscreenshot == 0.1 11:16:09 INFO - mozsystemmonitor == 0.3 11:16:09 INFO - moztest == 0.8 11:16:09 INFO - mozversion == 1.4 11:16:09 INFO - psutil == 3.1.1 11:16:09 INFO - requests == 1.2.3 11:16:09 INFO - wsgiref == 0.1.2 11:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:09 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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:16:09 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 11:16:09 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 11:16:09 INFO - Using env: {'DISPLAY': ':0', 11:16:09 INFO - 'HOME': '/home/cltbld', 11:16:09 INFO - 'LANG': 'en_US.UTF-8', 11:16:09 INFO - 'LANGUAGE': 'en_US:en', 11:16:09 INFO - 'LOGNAME': 'cltbld', 11:16:09 INFO - 'MAIL': '/var/mail/cltbld', 11:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:09 INFO - 'MOZ_NO_REMOTE': '1', 11:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:09 INFO - 'NO_EM_RESTART': '1', 11:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:09 INFO - 'PWD': '/builds/slave/test', 11:16:09 INFO - 'SHELL': '/bin/bash', 11:16:09 INFO - 'SHLVL': '1', 11:16:09 INFO - 'TERM': 'linux', 11:16:09 INFO - 'TMOUT': '86400', 11:16:09 INFO - 'USER': 'cltbld', 11:16:09 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:09 INFO - '_': '/tools/buildbot/bin/python'} 11:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 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)) 11:16:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:16:10 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)) 11:16:10 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)) 11:16:10 INFO - Installing collected packages: simplejson 11:16:10 INFO - Running setup.py install for simplejson 11:16:11 INFO - building 'simplejson._speedups' extension 11:16:11 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 11:16:11 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 11:16:11 INFO - Successfully installed simplejson 11:16:11 INFO - Cleaning up... 11:16:11 INFO - Return code: 0 11:16:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:12 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 0x20621f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, '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': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', '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 11:16:12 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 11:16:12 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 11:16:12 INFO - Using env: {'DISPLAY': ':0', 11:16:12 INFO - 'HOME': '/home/cltbld', 11:16:12 INFO - 'LANG': 'en_US.UTF-8', 11:16:12 INFO - 'LANGUAGE': 'en_US:en', 11:16:12 INFO - 'LOGNAME': 'cltbld', 11:16:12 INFO - 'MAIL': '/var/mail/cltbld', 11:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:12 INFO - 'MOZ_NO_REMOTE': '1', 11:16:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:12 INFO - 'NO_EM_RESTART': '1', 11:16:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:12 INFO - 'PWD': '/builds/slave/test', 11:16:12 INFO - 'SHELL': '/bin/bash', 11:16:12 INFO - 'SHLVL': '1', 11:16:12 INFO - 'TERM': 'linux', 11:16:12 INFO - 'TMOUT': '86400', 11:16:12 INFO - 'USER': 'cltbld', 11:16:12 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:12 INFO - '_': '/tools/buildbot/bin/python'} 11:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:12 INFO - Cleaning up... 11:16:12 INFO - Return code: 0 11:16:12 INFO - Running post-action listener: _resource_record_post_action 11:16:12 INFO - Running post-action listener: _start_resource_monitoring 11:16:12 INFO - Starting resource monitoring. 11:16:12 INFO - [mozharness: 2017-09-02 18:16:12.268493Z] Finished create-virtualenv step (success) 11:16:12 INFO - [mozharness: 2017-09-02 18:16:12.268962Z] Running install step. 11:16:12 INFO - Running pre-action listener: _resource_record_pre_action 11:16:12 INFO - Running main action method: install 11:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:12 INFO - Reading from file tmpfile_stdout 11:16:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:12 INFO - Reading from file tmpfile_stdout 11:16:12 INFO - Output received: 11:16:12 INFO - Usage: mozinstall [options] installer 11:16:12 INFO - Options: 11:16:12 INFO - -h, --help show this help message and exit 11:16:12 INFO - -d DEST, --destination=DEST 11:16:12 INFO - Directory to install application into. [default: 11:16:12 INFO - "/builds/slave/test"] 11:16:12 INFO - --app=APP Application being installed. [default: firefox] 11:16:12 INFO - mkdir: /builds/slave/test/build/application 11:16:12 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'] 11:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:16:29 INFO - Reading from file tmpfile_stdout 11:16:29 INFO - Output received: 11:16:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:16:29 INFO - Running post-action listener: _resource_record_post_action 11:16:29 INFO - [mozharness: 2017-09-02 18:16:29.129625Z] Finished install step (success) 11:16:29 INFO - [mozharness: 2017-09-02 18:16:29.129877Z] Running setup-mitmproxy step. 11:16:29 INFO - Running pre-action listener: _resource_record_pre_action 11:16:29 INFO - Running main action method: setup_mitmproxy 11:16:29 INFO - Skipping: mitmproxy is not required 11:16:29 INFO - Running post-action listener: _resource_record_post_action 11:16:29 INFO - [mozharness: 2017-09-02 18:16:29.131095Z] Finished setup-mitmproxy step (success) 11:16:29 INFO - [mozharness: 2017-09-02 18:16:29.131315Z] Running run-tests step. 11:16:29 INFO - Running pre-action listener: _resource_record_pre_action 11:16:29 INFO - Running pre-action listener: _set_gcov_prefix 11:16:29 INFO - Running main action method: run_tests 11:16:29 WARNING - Try message not found. 11:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:29 INFO - Python 2.7.3 11:16:29 INFO - Return code: 0 11:16:29 INFO - grabbing minidump binary from tooltool 11:16:29 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')]} 11:16:29 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 0x23d2090>, '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 0x23d2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23ccf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:29 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 11:16:29 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 11:16:29 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 11:16:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:29 INFO - Return code: 0 11:16:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:16:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:29 INFO - ENV: RUST_BACKTRACE is now full 11:16:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:16:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:29 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/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 11:16:29 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/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 11:16:29 INFO - Using env: {'DISPLAY': ':0', 11:16:29 INFO - 'HOME': '/home/cltbld', 11:16:29 INFO - 'LANG': 'en_US.UTF-8', 11:16:29 INFO - 'LANGUAGE': 'en_US:en', 11:16:29 INFO - 'LOGNAME': 'cltbld', 11:16:29 INFO - 'MAIL': '/var/mail/cltbld', 11:16:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:29 INFO - 'MOZ_NO_REMOTE': '1', 11:16:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:29 INFO - 'NO_EM_RESTART': '1', 11:16:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:29 INFO - 'PWD': '/builds/slave/test', 11:16:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:29 INFO - 'RUST_BACKTRACE': 'full', 11:16:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:29 INFO - 'SHELL': '/bin/bash', 11:16:29 INFO - 'SHLVL': '1', 11:16:29 INFO - 'STYLO_FORCE_ENABLED': '1', 11:16:29 INFO - 'STYLO_THREADS': '1', 11:16:29 INFO - 'TERM': 'linux', 11:16:29 INFO - 'TMOUT': '86400', 11:16:29 INFO - 'USER': 'cltbld', 11:16:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:29 INFO - '_': '/tools/buildbot/bin/python'} 11:16:29 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/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 11:16:29 INFO - mozversion application_buildid: 20170902172544 11:16:29 INFO - mozversion application_changeset: 59611e1583e7411bab615d29109894e4c657af33 11:16:29 INFO - mozversion application_display_name: Nightly 11:16:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:29 INFO - mozversion application_name: Firefox 11:16:29 INFO - mozversion application_remotingname: firefox 11:16:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:16:29 INFO - mozversion application_vendor: Mozilla 11:16:29 INFO - mozversion application_version: 57.0a1 11:16:29 INFO - mozversion platform_buildid: 20170902172544 11:16:29 INFO - mozversion platform_changeset: 59611e1583e7411bab615d29109894e4c657af33 11:16:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:16:29 INFO - mozversion platform_version: 57.0a1 11:16:29 INFO - using testdate: 1504376189 11:16:29 INFO - actual date: 1504376189 11:16:29 INFO - starting webserver on 'localhost:33728' 11:16:29 INFO - SUITE-START | Running 2 tests 11:16:29 INFO - TEST-START | dromaeo_css 11:16:29 INFO - Initialising browser for dromaeo_css test... 11:16:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33728/getInfo.html -profile /tmp/tmpYsGkCn/profile 11:16:29 INFO - TEST-INFO | started process 14182 (/builds/slave/test/build/application/firefox/firefox http://localhost:33728/getInfo.html) 11:16:34 INFO - TEST-INFO | 14182: exit 0 11:16:34 INFO - Browser initialized. 11:16:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:34 INFO - Using env: {'DISPLAY': ':0', 11:16:34 INFO - 'HOME': '/home/cltbld', 11:16:34 INFO - 'JSGC_DISABLE_POISONING': '1', 11:16:34 INFO - 'LANG': 'en_US.UTF-8', 11:16:34 INFO - 'LANGUAGE': 'en_US:en', 11:16:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:16:34 INFO - 'LOGNAME': 'cltbld', 11:16:34 INFO - 'MAIL': '/var/mail/cltbld', 11:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:34 INFO - 'MOZ_CRASHREPORTER': '1', 11:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:16:34 INFO - 'MOZ_NO_REMOTE': '1', 11:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:34 INFO - 'NO_EM_RESTART': '1', 11:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:34 INFO - 'PWD': '/builds/slave/test', 11:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:34 INFO - 'RUST_BACKTRACE': 'full', 11:16:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:34 INFO - 'SHELL': '/bin/bash', 11:16:34 INFO - 'SHLVL': '1', 11:16:34 INFO - 'STYLO_FORCE_ENABLED': '1', 11:16:34 INFO - 'STYLO_THREADS': '1', 11:16:34 INFO - 'TERM': 'linux', 11:16:34 INFO - 'TMOUT': '86400', 11:16:34 INFO - 'USER': 'cltbld', 11:16:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:34 INFO - '_': '/tools/buildbot/bin/python'} 11:16:34 INFO - TEST-INFO | started process 14368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYsGkCn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:35 INFO - PID 14368 | 11:16:35 INFO - PID 14368 | (/builds/slave/test/build/application/firefox/firefox:14420): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:16:35 INFO - PID 14368 | 11:16:46 INFO - PID 14368 | RSS: Main: 172081152 11:16:46 INFO - PID 14368 | 11:19:44 INFO - PID 14368 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33728/tests/dromaeo/cssquery-ext.html) 11:19:46 INFO - PID 14368 | RSS: Main: 174370816 11:19:46 INFO - PID 14368 | 11:22:47 INFO - PID 14368 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-ext.html (next: http://localhost:33728/tests/dromaeo/cssquery-jquery.html) 11:22:48 INFO - PID 14368 | RSS: Main: 171102208 11:22:48 INFO - PID 14368 | 11:25:50 INFO - PID 14368 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33728/tests/dromaeo/cssquery-mootools.html) 11:25:50 INFO - PID 14368 | RSS: Main: 173133824 11:25:50 INFO - PID 14368 | 11:28:52 INFO - PID 14368 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33728/tests/dromaeo/cssquery-prototype.html) 11:28:52 INFO - PID 14368 | RSS: Main: 171626496 11:28:52 INFO - PID 14368 | 11:31:56 INFO - PID 14368 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33728/tests/dromaeo/cssquery-yui.html) 11:31:57 INFO - PID 14368 | RSS: Main: 172769280 11:31:57 INFO - PID 14368 | 11:34:58 INFO - PID 14368 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-yui.html (next: http://localhost:33728/tests/dromaeo/cssquery-dojo.html) 11:34:59 INFO - PID 14368 | RSS: Main: 175378432 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | __start_tp_report 11:34:59 INFO - PID 14368 | _x_x_mozilla_page_load 11:34:59 INFO - PID 14368 | _x_x_mozilla_page_load_details 11:34:59 INFO - PID 14368 | |i|pagename|runs| 11:34:59 INFO - PID 14368 | |0;dojo.html;3293.3248684019763;3346;3354.144693103259;3362.512435696824;3375.8987230383095;6355.777547785829;6450.612963222204;6478.578892371993;6511.772087976922;6558.147440832697;6312.526560507958;6373;6390;6390.329015453381;6410.615363078218;5737.426257374271;5738.6556806591525;5757.769689212448;5766.481016708495;5789.739461724233;5803.8258852234285;5910.645361278315;5913.674747888865;5991.85020374492;6002.429769171922;5871.559633027518;5880.5883588148845;5961.493273071794;5998.25021872266;6064.4541991220785;5636.0982242841355;5700.7149642518125;5842.824715258549;5848.941510584925;5977.581569290108;5594.13290939905;5685.829425117253;5776.855578610526;5849.941500584982;5900.232969713953;6332;6459.257185423689;6461.547691661585;6517.0224466329955;6543.214814222276;6828.214755303154;6868.793936181923;6900.6204658743745;6906.343897329796;6910.170779506491;6933.306669333077;6963.930360696379;6977.232504424509;6978.092847929787;7045.788626341218;6387.361263873622;6407.583507072072;6412.973924172204;6512.055751915993;6521.93478065218;6909.861802763917;7033.296670332926;7054.329838665319;7102.573845569179;7170.1754298256365;6639.800805975829;6642.568233064835;6644.103046088716;6650.235222949326;6654.633995130314;6668.933310666831;6752.561083529555;6754.986751987241;6764.323567643295;6764.695588698521;6722.798316050526;6827.6244806536115;6928.237893831674;6959.791206263821;6973.79078627642;6802.455803535705;6815.795526134224;6825.1809782825385;6859.279775623588;6889.862202755917;5001.599872010231;5023.773930173151;5074.0359331727595;5114.028334616411;5117.948820511747;4356.847510337123;4417.60241578253;4475.462944446687;4546.909061818745;4567.1550763108935;6079.817605471843;6088.11722300264;6103.877922441527;6139.693015349215;6144.41628045335;6914.274001229899;6935.133108361455;6946.37482626566;7014.964925175444;7031.8945215821805;5877.588568800143;5966.671833049137;5970.58205925581;6063.878722425527;6142.754289828446;5884.529237661062;5903.881922361528;5938.406159384113;5980.252468441445;5988.850278743066;6659.700313485905;6751.831204219836;6791.830204244933;6796.966015169893;6797.0144329073;6778.254392016973;6884.793456196322;6946.201186863374;6967.895481567882;6997.090378250795;6536.705848236746;6639.136912201383;6658.43403310724;6662.700178492077;6725.923852183822;6807.285235050248;6818.113645226089;6827.48793840454;6830.829229269308;6837.829054273683;6960.269171737097;6990.335918087773;7040.0847889774;7068.434525237866;7068.540544864567;6721.697523611351;6732.764353247613;6821.522493425413;6827.351401616838;6827.829304267234;6527.477801775752;6630.071789949315;6636.568623039487;6708.798736037927;6809.693563789542;6680.432163266177;6696.430803381767;6698.062271282122;6700.698468569024;6752.898706519504;6748.93251067483;6799.694013769294;6823.522353435212;6844.178698556006;6874.793756187322;6342.207224096988;6450.48396128318;6457.838554036187;6539.803805885831;6644.335566443317 11:34:59 INFO - PID 14368 | |1;ext.html;748.7903387051624;800.5196881870878;826.1449399871133;831.8585840407134;1116.2242241642061;30119.84940075299;30696.232594185156;30735.692643073562;39791.60208397915;40327.19345613093;39666;39937.20125597486;40001.19997600046;40220.79889600548;40274.59725402745;7107.147142342926;7381.520201186932;7486.925130748705;7495.138059123216;7523.811904702399;7438.144613369451;7528.284812942789;7536.397088232929;7564;7581;7515.812104697399;7542.35889949355;7581.431392645546;7594.848103037936;7608.239176082375;7557.924420755805;7561.810954726121;7570.583617901013;7571.77284681455;7574.507657002332;7476.626168691544;7517.812054698622;7517.887231691474;7532.133804612485;7532.698692052311;35721.28557428863;35927.281454370765;36091;36119.81940090309;36120.81939590311;3540;3581.033121057326;3583.4803953426867;3584.6773790358993;3586.3185994661194;30376.696233037608;30448.54327185094;30496.847515762278;30506;30572;5162.974185129088;5193.169092945149;5194.402643695986;5231.450697676765;5240.554552863011;184980;185824.07087964608;186970;187168;187208;46048;46074.769626151654;46137.76931115323;46149.30776038362;46177;48781.26828097581;48823;48930.26604600934;48979.51020489821;49057.50942490529;15386.9230653846;15715.842841571666;15734.763978540332;15737.44918927855;15772.369105235663;11628.767424651629;11707.239029463057;12908.806367904488;13000;13018.349082545836;13709.245991470365;13710.38303276355;13731.725365492834;13863.653408664864;13932.721345573033;5413.404525502192;5491.28613280271;5595.209532949499;5639.379668236491;5682.602217844711;990.5493000684671;1002.3735165521549;1005.3867141043958;1008.2992320337441;1009.2077718990557;21892.78107218939;22296;22336.106555737915;22365.776342236695;22410.32769016932;1079.659767733706;1085.3054045410943;1099.6096385783092;1104.9337039777638;1106.6790630717162;11913.344766037952;11980.341081240442;15437.768433473508;15533;15735;224773;227736;228096;229047;229834;53394.73302633462;53856;53921.1911821323;54069;54252.72873635607;1422.3101795629111;1449.6665766873678;1454.447310022206;1455.978160327596;1459.7080583883053;26082;26626.600600990612;26643.200703978913;26705.866470667523;26793.19620411391;36287.637123628425;36443.817780910926;36750;36779.26441471209;36799.816000920895;198622;199190;200336;200452;200518;32772.34455310928;32903;32986.34027319488;33283.167920802174;33343.333133337685;38773.612263877;40608;40723.79638101909;40907;40908.386374203816;29541.704582954757;30366.69633303727;30685.386292274477;30702;31274;29800.850995744884;29888.136914818493;29957.639592262643;30239.546406804355;30488.84755576208;34169.14577135492;34207.14482137966;34484;34515.309693806485;34635.65364346425;29120.417591647623;29645.25886852846;29744.512774360763;29859.552106718853;30606.540901886936;22602.434939126655;22655.88672056629;22726;24165.879170604738;24533.87733061323 11:34:59 INFO - PID 14368 | |2;jquery.html;563.5660541383135;565.9484369161788;567.7672154416688;569.4476357932806;582.3157789597223;21395;22089.558208835813;22099.779002209973;22164.335069947887;22885.31344059677;25094.498110037788;25387.492250154985;25586.10448634298;25594;25607.231783046493;6548.05053267276;6693.297203793604;6695.230048544407;6696.799096027103;6700.061991321219;5778.3643799182055;6452.257990331102;6479.254885688136;6487.545871788977;6548;6459.224893012822;6464;6465.224173099211;6467.385598368171;6472.190976127984;6439.967800160993;6446.806595802133;6448.64532450715;6452.967735161341;6454.903176452357;5970.940290597126;5989.161517387569;5990;5990.8502287442725;6011.969940150271;28202.15393538197;28796.42407151866;29069.563956540667;29360.41279174426;29451.410971780446;1986.5430950881378;2017.5561376497294;2018.6971954206986;2020.111151093514;2022.7168196452508;18502.44492665222;18998.62002759951;19030.238790448366;19042.42872713821;19060.61878762431;2415.758424157588;2424.260600516842;2475.2697954103583;2475.7648023437746;2479.256223133053;129296;130951.34524327317;132269;134923.32538337345;134935;13973.930130349283;14048.508302209373;14448.638784030272;14677;14896.404143834125;22939.426514337276;22980.310590681973;23031.424214394774;23072;23119.768802312097;9793.853092203623;10106.949465252774;10147.289689721649;10149.34029288094;10169.745756356151;8379.162083791694;9300.20948219409;9415.186849326034;9468.90531094694;9525.809483810424;7810.789327654223;8846.77883052916;8862.734117976472;8954.58226278901;9149.902011758499;2612.843229406242;2665.9075472451864;2687.7446642568925;2774.6958929303196;2827.6889542150348;952.9761755956157;976.8730065091635;983.9360441571275;987.8666380038603;1007.5717819926502;19387.612247754965;19500.02499875029;19625.411237662895;20052.298169563994;23939.28182154538;1039.875214974208;1060.9045185933303;1079.4117206122683;1083.913286937043;1095.46322302073;10932.781344373227;11059.502322395512;11524.423778811193;11524.59663911759;11576.36330001858;490411;496138;516810;519259;523239;118223;119156;119691.40154299347;119779;124169.37915310365;1237.3627581795383;1240.8448943882015;1284.6146156153118;1285.9099863009687;1288.491046036829;20773;21103.683444748032;21112;21137.260195893068;21615.135394584042;55670.72164639151;57029.71485142548;57453.71273143608;59188;60233.096503551606;66302.33697663154;66587;66927.3307266921;67127.99308010482;67353.32646673471;14558.636034099232;14931.701365972836;14968.550943471713;15021.849781502482;15057.77413338779;23111.537769244856;23744.762552374945;23855.52288954246;23867.761322386556;23958.281251562483;18615.813841861407;18746.812531875054;18811.05944702732;19125.521861953563;19141.808581914003;16730.24713887902;17072.231749571052;17403.390881319094;17410.39063632767;17920.91039544794;18744.906275469082;19370.12834422426;19388.12753426071;19433.54248431345;19449.611007780048;14407.855921440652;14660.193689347188;14737.631559211106;14748.525147485165;14808.62978425548;18831.6233675323;18895.905520472308;19022.7146592804;19033.238670453025;19124.71312930335 11:34:59 INFO - PID 14368 | |3;mootools.html;1309.927953962532;1335.1788649980258;1358.0765079745775;1360.6054244269162;1377.5040985245314;14937.775933360994;15587.610309742247;15614.063156210635;15626.687466250669;15693.529194124167;15725.449609263678;15928.681426371466;15970.920145399286;15973.361065557392;15995.200239987984;2713.6472258606354;2763.088180900308;2823.5623478360885;2825.3784167483223;2826;2830.9292267693368;2855.6287682601233;2860.556613724876;2862.957055644167;2865.169100960719;2773.320536468568;2796.0772944928226;2811.8594070296504;2849.2164654720013;2911.577821215933;2660.0157941561647;2680.048582753124;2690.9058182963504;2694.0840114361113;2695.8382497050043;2660.7472290132405;2680.5175068487665;2681.2894582935537;2703.7972152088473;2712.0236714782664;14771.482998095122;14915.403383864632;14975;14977.550673479813;14978.700425991528;8083.636236369378;8368;8377.078521362646;8378.622961966727;8389.790255243606;5464.562834973192;5556.305461817273;5598.804041858556;5725.08398656213;5742.712864356808;1777.2446710148135;1779.4839496545985;1802.0719329545295;1811.3479147506887;1828.6434145341664;26751.197464076107;26828.463430731277;26914.5962810558;27055.188344349703;27091.322716932038;6483.189601299838;6723.361280678328;6929.514933954676;7064.293570642997;7230.349268565854;17287.308507659553;17328.393506227472;17354.652906941792;17375.73936390955;17393.65212695739;7931.484453510503;8141.674333026731;8144.633491492897;8180.672773089129;8236.299914507334;7462.403007759366;7476.70093196266;7597.506162099446;7622.58075805836;7665.61671916402;5209.973950130225;5372.5970552207955;5391.32608423947;5412.702301373383;5435.809746658927;1485.851414858527;1486.2791546100132;1490.3665941974618;1490.545383657973;1506.5103841251637;879.76246413468;898.6071589036967;904.5070436612062;916.6425094213262;923.8614207868874;7800.375969922393;7836.138024817265;7889.09275433321;7918.129005809356;7957.602119894098;717.8564287142592;722.7759394587695;726.4116065986568;735.4631119282953;740.7703611880335;4744.881377965509;4786.401699787527;4797.040591881638;4877.3903262092235;4883.902321953541;21023.8948805255;21100.261490848054;22140.778592214192;22172.445688857584;22196.223132190295;21212.469688257916;21224.469388265417;21743.23898663539;21912.561748765253;21918.342449726533;10825.350478971286;10948.890511094947;11015.504302306415;11061.5022323994;11086.16853735973;8578.142185781371;8615.3107751381;8670.393072484865;8686.913130868863;8737.21365077146;17652.646947061243;18208;18466.907665461586;18533.53666158357;18622.255109795457;18994.905025474785;19133.617327653646;19147.521311967314;19147.61704765869;19390.515237119183;11902.226355286879;12497.437615307515;12529.248245105322;12531.18547294423;12559.686007849878;14029.3686784097;14062.156270623795;14158.221297828306;14167.716645666822;14211.289435527975;10805.621803236849;10904.400257985886;10904.7273818152;11063.778724425627;11109.500072496596;11003.944980275048;11159.107271418105;11196.608118716133;11206.663800086011;11381;9817.754556136153;9932.205423566242;9932.304738668225;9932.702018939442;9936.602535898483;7031.507794454339;7064.752733654297;7070.964645176947;7074.575525468488;7123.750668726777;7333.413326933725;7357.632118394166;7377.446691498052;7393.852122957618;7490.550566966 11:34:59 INFO - PID 14368 | |4;prototype.html;490.49234042765744;507.1454599000683;531.1846315905086;537.113762292218;537.4679067722954;6329.968350158254;6336.873262534758;6388.169537960064;6448.613083214998;6465.224173099229;6051;6133.846653833645;6194.853952018869;6286.622802631845;6326.936730632692;5038.647294689373;5041.865580244443;5056.696598204119;5078.974605126988;5090.465501122384;5083.974580127094;5087.592992560586;5099.872503187431;5107.182850743881;5121.385433747937;4815.133276010317;4918.754062296871;4977.676451030671;5037.319961805164;5056.418511871145;4899.681520701143;4935.728534930578;4983.327250821129;5000.399952005746;5033.7734801934;4413.646908247332;4437.933430998538;4439.800208990603;4442.178197033559;4481.462224533045;6122.387761223887;6152.661603611799;6202.503799696014;6213.2233470816145;6222.439980401786;5643.8589035274035;5677.432256774331;5721.456461636138;5722.456366645162;5746.224259724967;6559.720854433387;6608.306127856554;6643.87054200787;6688.398044175999;6698.162729658793;4800.279958006292;4803.279508073782;4834.734089625104;4854.543636908948;4886.682365646222;6956.478264130211;7010.859782804367;7039.683214255422;7042.6126563039015;7043.6478176091505;5041.395032596039;5081;5085;5086.262491938722;5121.539061484485;5076.289319495274;5077.974610126926;5113.284140220372;5160.845174644766;5168.715720635401;5681.403452637496;5698.233547600257;5714.314282286069;5720.42795720433;5751.741171647286;6646.501512386493;6689.13041304637;6714.832129196711;6750.1562304711915;6762.72949082041;1653.5204790610828;1752.8422441980283;1770.4069136839303;1772.9202185901408;1794.6321004194108;1141.7259857634108;1192.356127691037;1196.9341686207167;1208.9758204835855;1231.3904617214357;5775.826725198251;5876.823695289148;5895.170318247266;5901.232839730894;5921.40785921413;6610.206775186912;6614.8346291343105;6626.0966884505115;6644.700988455531;6733.966330168318;5723.427657234243;5787;5798.391168927286;5866.413358664185;5866.472017518444;3467.8959631211105;3561.679448849616;3566.1262990567475;3572.6427357264583;3594.155373487228;6241;6390.84022899422;6419;6488.448481879093;6489.935100648933;6640.169978752656;6710.1947766267385;6843.965780171067;6852.931470685329;6868.896966545506;6407.327230640902;6474.417302442803;6478.2873883872735;6501.44737697301;6527.596566738174;6573.80278591643;6620.205575330991;6678.131842860591;6693.631850248283;6716.798496045127;6638.701258443478;6651.600903945779;6677.29888361715;6679.332066793282;6700.396964273239;6467.7736279231885;6481.578697384655;6495.253045899782;6530.771423000172;6535.411812936859;4916.287138364989;4948.331975183304;4962.875928101682;4972.930819873744;4983.227599722049;6627.436667883284;6659.900101498384;6698.430633396021;6714.563553369016;6750.257471678014;6340.9048864268;6392.93607063942;6471.902921456088;6494.902576461452;6535.640539770358;6450.903236451363;6494;6500.414962653384;6501.2198536175965;6541.378569035934;6254.967930291451;6284.465820405317;6459.289478157305;6465.741370345134;6495.271985766084;6622.437092847162;6684.197896252481;6728.899066514105;6736.8652626946205;6741.1236539249585;6391.552591318563;6418.29398766126;6445.584774429531;6447.548671592944;6507.577007494687 11:34:59 INFO - PID 14368 | |5;yui.html;897.8742975983359;916.5966974531206;917.1333090229733;919.737874705709;924.5608336040382;17315.653686926253;17590.944543327376;17708.46874593761;17732.20205090771;21427.785722142773;20655.793442065577;21244.575108497822;21350.679739803916;21382.25162119326;21505.784942150574;961.3414810854587;977.8777652793401;981.8723565936418;984.3109823123806;985.8866230383491;892.3619611977435;993.7962717642902;993.8707967964154;994.2592768387561;995.8356871116293;1045.263089521889;1050.4485145298702;1053.984190237147;1054.9261551691384;1056.0495554001384;1049.664107485605;1050.616524968385;1051.3113910388709;1051.5898799468137;1051.8422236664524;760.505671313645;762.3405754022731;767.2212704105337;767.4474378447509;769.5190505933791;17141.228644711016;17343;17478.650426991517;17580.648387032317;17903.37338193157;20247.29134480301;20721.792782072287;21182.5763484731;21364.46588835276;21401.464963376042;16485.423010194587;16530.421435249707;16625.83374166255;16628.83371166285;16641.41755038568;3718.7768733876055;3745.194783121615;3746;3747.9625203747887;3748.0817199785956;124478.37760811138;125124;125559;127408;129819;16347.673046539003;16369.754453683205;16728.41450549225;16910.154492275582;16956.15219239033;29127.854360728485;30529.08412747621;30623.8468807659;30681.539776903363;30714.385712285628;8003.559804210824;8148.51108933454;8168.305694015957;8171.305439037748;8174;4303.569643035671;4364.672649551297;4409.184300904343;4414.227510185705;4415.315626077963;5278.8944221116135;5313.990341835039;5357.491038351351;5358.2498450217;5373.731313434313;1113.8050841102774;1125.859267591551;1142.457332766929;1150.827375893606;1155.1451925575013;684.4968947823346;701.6421624971301;706.8444942112727;711.3206887422499;712.2343480758205;11890;12385.876141238652;12499.56251531192;13271.867281327257;13301.600951971457;693.4036728413561;697.264386072688;708.8157079159456;721.249900103886;723.4104205072849;5484.765927666243;5651.717414129359;5857.88284234313;6410;6415.775447859302;106785.46607266914;109714;110202;116227.41886290515;117806.41096794461;102357.48821255846;104050;106263.4686826561;108699.45650271856;110173.44913275383;89595.10404895998;92735;93444.53277733704;94930;96681;11301.547938082713;12138.817917731065;12637.241765493733;13233.942203924893;13411;39552.40671389989;40279.3958090623;41019.58980410277;42024.789876050425;42646.36030459608;51631.22553161631;51938.480615193366;52461;54838.72580637071;68518;18800;19141.181587749143;19252.326168584033;19386.612267754284;19497.610047799248;21383.14467421348;22275.108995639992;22370.32889013332;22580;22585.774142259026;18007.63984720272;18134.72797908006;19337.41987740314;19519.926404047914;19638.214471421554;19341.12964916554;19472.90263548673;19694.212231511152;19983.60032799365;20041.799582003994;18067.277308908022;18373.724394134366;18387.448376548724;18954.43136705901;19154.138063787443;12528.624141275777;12605.810912836132;12607.180533265308;12693.238405695687;12848.807267890803;13311;13603.251821149932;14247.147870776733;14596.854031459974;15061.698766024838 11:34:59 INFO - PID 14368 | __end_tp_report 11:34:59 INFO - PID 14368 | __start_cc_report 11:34:59 INFO - PID 14368 | _x_x_mozilla_cycle_collect,376 11:34:59 INFO - PID 14368 | __end_cc_report 11:34:59 INFO - PID 14368 | __startTimestamp1504377299125__endTimestamp 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | ------- Summary: start ------- 11:34:59 INFO - PID 14368 | Number of tests: 6 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | [#0] dojo.html Cycles:165 Average:6318.77 Median:6636.57 stddev:785.56 (11.8%) stddev-sans-first:751.26 11:34:59 INFO - PID 14368 | Values: 3293.3 3346.0 3354.1 3362.5 3375.9 6355.8 6450.6 6478.6 6511.8 6558.1 6312.5 6373.0 6390.0 6390.3 6410.6 5737.4 5738.7 5757.8 5766.5 5789.7 5803.8 5910.6 5913.7 5991.9 6002.4 5871.6 5880.6 5961.5 5998.3 6064.5 5636.1 5700.7 5842.8 5848.9 5977.6 5594.1 5685.8 5776.9 5849.9 5900.2 6332.0 6459.3 6461.5 6517.0 6543.2 6828.2 6868.8 6900.6 6906.3 6910.2 6933.3 6963.9 6977.2 6978.1 7045.8 6387.4 6407.6 6413.0 6512.1 6521.9 6909.9 7033.3 7054.3 7102.6 7170.2 6639.8 6642.6 6644.1 6650.2 6654.6 6668.9 6752.6 6755.0 6764.3 6764.7 6722.8 6827.6 6928.2 6959.8 6973.8 6802.5 6815.8 6825.2 6859.3 6889.9 5001.6 5023.8 5074.0 5114.0 5117.9 4356.8 4417.6 4475.5 4546.9 4567.2 6079.8 6088.1 6103.9 6139.7 6144.4 6914.3 6935.1 6946.4 7015.0 7031.9 5877.6 5966.7 5970.6 6063.9 6142.8 5884.5 5903.9 5938.4 5980.3 5988.9 6659.7 6751.8 6791.8 6797.0 6797.0 6778.3 6884.8 6946.2 6967.9 6997.1 6536.7 6639.1 6658.4 6662.7 6725.9 6807.3 6818.1 6827.5 6830.8 6837.8 6960.3 6990.3 7040.1 7068.4 7068.5 6721.7 6732.8 6821.5 6827.4 6827.8 6527.5 6630.1 6636.6 6708.8 6809.7 6680.4 6696.4 6698.1 6700.7 6752.9 6748.9 6799.7 6823.5 6844.2 6874.8 6342.2 6450.5 6457.8 6539.8 6644.3 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | [#1] ext.html Cycles:180 Average:36757.94 Median:33134.75 stddev:53196.45 (160.5%) stddev-sans-first:53276.96 11:34:59 INFO - PID 14368 | Values: 748.8 800.5 826.1 831.9 1116.2 30119.8 30696.2 30735.7 39791.6 40327.2 39666.0 39937.2 40001.2 40220.8 40274.6 7107.1 7381.5 7486.9 7495.1 7523.8 7438.1 7528.3 7536.4 7564.0 7581.0 7515.8 7542.4 7581.4 7594.8 7608.2 7557.9 7561.8 7570.6 7571.8 7574.5 7476.6 7517.8 7517.9 7532.1 7532.7 35721.3 35927.3 36091.0 36119.8 36120.8 3540.0 3581.0 3583.5 3584.7 3586.3 30376.7 30448.5 30496.8 30506.0 30572.0 5163.0 5193.2 5194.4 5231.5 5240.6 184980.0 185824.1 186970.0 187168.0 187208.0 46048.0 46074.8 46137.8 46149.3 46177.0 48781.3 48823.0 48930.3 48979.5 49057.5 15386.9 15715.8 15734.8 15737.4 15772.4 11628.8 11707.2 12908.8 13000.0 13018.3 13709.2 13710.4 13731.7 13863.7 13932.7 5413.4 5491.3 5595.2 5639.4 5682.6 990.5 1002.4 1005.4 1008.3 1009.2 21892.8 22296.0 22336.1 22365.8 22410.3 1079.7 1085.3 1099.6 1104.9 1106.7 11913.3 11980.3 15437.8 15533.0 15735.0 224773.0 227736.0 228096.0 229047.0 229834.0 53394.7 53856.0 53921.2 54069.0 54252.7 1422.3 1449.7 1454.4 1456.0 1459.7 26082.0 26626.6 26643.2 26705.9 26793.2 36287.6 36443.8 36750.0 36779.3 36799.8 198622.0 199190.0 200336.0 200452.0 200518.0 32772.3 32903.0 32986.3 33283.2 33343.3 38773.6 40608.0 40723.8 40907.0 40908.4 29541.7 30366.7 30685.4 30702.0 31274.0 29800.9 29888.1 29957.6 30239.5 30488.8 34169.1 34207.1 34484.0 34515.3 34635.7 29120.4 29645.3 29744.5 29859.6 30606.5 22602.4 22655.9 22726.0 24165.9 24533.9 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | [#2] jquery.html Cycles:180 Average:35313.05 Median:23005.87 stddev:85437.34 (371.4%) stddev-sans-first:85637.18 11:34:59 INFO - PID 14368 | Values: 563.6 565.9 567.8 569.4 582.3 21395.0 22089.6 22099.8 22164.3 22885.3 25094.5 25387.5 25586.1 25594.0 25607.2 6548.1 6693.3 6695.2 6696.8 6700.1 5778.4 6452.3 6479.3 6487.5 6548.0 6459.2 6464.0 6465.2 6467.4 6472.2 6440.0 6446.8 6448.6 6453.0 6454.9 5970.9 5989.2 5990.0 5990.9 6012.0 28202.2 28796.4 29069.6 29360.4 29451.4 1986.5 2017.6 2018.7 2020.1 2022.7 18502.4 18998.6 19030.2 19042.4 19060.6 2415.8 2424.3 2475.3 2475.8 2479.3 129296.0 130951.3 132269.0 134923.3 134935.0 13973.9 14048.5 14448.6 14677.0 14896.4 22939.4 22980.3 23031.4 23072.0 23119.8 9793.9 10106.9 10147.3 10149.3 10169.7 8379.2 9300.2 9415.2 9468.9 9525.8 7810.8 8846.8 8862.7 8954.6 9149.9 2612.8 2665.9 2687.7 2774.7 2827.7 953.0 976.9 983.9 987.9 1007.6 19387.6 19500.0 19625.4 20052.3 23939.3 1039.9 1060.9 1079.4 1083.9 1095.5 10932.8 11059.5 11524.4 11524.6 11576.4 490411.0 496138.0 516810.0 519259.0 523239.0 118223.0 119156.0 119691.4 119779.0 124169.4 1237.4 1240.8 1284.6 1285.9 1288.5 20773.0 21103.7 21112.0 21137.3 21615.1 55670.7 57029.7 57453.7 59188.0 60233.1 66302.3 66587.0 66927.3 67128.0 67353.3 14558.6 14931.7 14968.6 15021.8 15057.8 23111.5 23744.8 23855.5 23867.8 23958.3 18615.8 18746.8 18811.1 19125.5 19141.8 16730.2 17072.2 17403.4 17410.4 17920.9 18744.9 19370.1 19388.1 19433.5 19449.6 14407.9 14660.2 14737.6 14748.5 14808.6 18831.6 18895.9 19022.7 19033.2 19124.7 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | [#3] mootools.html Cycles:180 Average:9410.87 Median:2699.82 stddev:6737.74 (249.6%) stddev-sans-first:6729.15 11:34:59 INFO - PID 14368 | Values: 1309.9 1335.2 1358.1 1360.6 1377.5 14937.8 15587.6 15614.1 15626.7 15693.5 15725.4 15928.7 15970.9 15973.4 15995.2 2713.6 2763.1 2823.6 2825.4 2826.0 2830.9 2855.6 2860.6 2863.0 2865.2 2773.3 2796.1 2811.9 2849.2 2911.6 2660.0 2680.0 2690.9 2694.1 2695.8 2660.7 2680.5 2681.3 2703.8 2712.0 14771.5 14915.4 14975.0 14977.6 14978.7 8083.6 8368.0 8377.1 8378.6 8389.8 5464.6 5556.3 5598.8 5725.1 5742.7 1777.2 1779.5 1802.1 1811.3 1828.6 26751.2 26828.5 26914.6 27055.2 27091.3 6483.2 6723.4 6929.5 7064.3 7230.3 17287.3 17328.4 17354.7 17375.7 17393.7 7931.5 8141.7 8144.6 8180.7 8236.3 7462.4 7476.7 7597.5 7622.6 7665.6 5210.0 5372.6 5391.3 5412.7 5435.8 1485.9 1486.3 1490.4 1490.5 1506.5 879.8 898.6 904.5 916.6 923.9 7800.4 7836.1 7889.1 7918.1 7957.6 717.9 722.8 726.4 735.5 740.8 4744.9 4786.4 4797.0 4877.4 4883.9 21023.9 21100.3 22140.8 22172.4 22196.2 21212.5 21224.5 21743.2 21912.6 21918.3 10825.4 10948.9 11015.5 11061.5 11086.2 8578.1 8615.3 8670.4 8686.9 8737.2 17652.6 18208.0 18466.9 18533.5 18622.3 18994.9 19133.6 19147.5 19147.6 19390.5 11902.2 12497.4 12529.2 12531.2 12559.7 14029.4 14062.2 14158.2 14167.7 14211.3 10805.6 10904.4 10904.7 11063.8 11109.5 11003.9 11159.1 11196.6 11206.7 11381.0 9817.8 9932.2 9932.3 9932.7 9936.6 7031.5 7064.8 7071.0 7074.6 7123.8 7333.4 7357.6 7377.4 7393.9 7490.6 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | [#4] prototype.html Cycles:180 Average:5530.67 Median:6207.86 stddev:1553.39 (25.0%) stddev-sans-first:1510.98 11:34:59 INFO - PID 14368 | Values: 490.5 507.1 531.2 537.1 537.5 6330.0 6336.9 6388.2 6448.6 6465.2 6051.0 6133.8 6194.9 6286.6 6326.9 5038.6 5041.9 5056.7 5079.0 5090.5 5084.0 5087.6 5099.9 5107.2 5121.4 4815.1 4918.8 4977.7 5037.3 5056.4 4899.7 4935.7 4983.3 5000.4 5033.8 4413.6 4437.9 4439.8 4442.2 4481.5 6122.4 6152.7 6202.5 6213.2 6222.4 5643.9 5677.4 5721.5 5722.5 5746.2 6559.7 6608.3 6643.9 6688.4 6698.2 4800.3 4803.3 4834.7 4854.5 4886.7 6956.5 7010.9 7039.7 7042.6 7043.6 5041.4 5081.0 5085.0 5086.3 5121.5 5076.3 5078.0 5113.3 5160.8 5168.7 5681.4 5698.2 5714.3 5720.4 5751.7 6646.5 6689.1 6714.8 6750.2 6762.7 1653.5 1752.8 1770.4 1772.9 1794.6 1141.7 1192.4 1196.9 1209.0 1231.4 5775.8 5876.8 5895.2 5901.2 5921.4 6610.2 6614.8 6626.1 6644.7 6734.0 5723.4 5787.0 5798.4 5866.4 5866.5 3467.9 3561.7 3566.1 3572.6 3594.2 6241.0 6390.8 6419.0 6488.4 6489.9 6640.2 6710.2 6844.0 6852.9 6868.9 6407.3 6474.4 6478.3 6501.4 6527.6 6573.8 6620.2 6678.1 6693.6 6716.8 6638.7 6651.6 6677.3 6679.3 6700.4 6467.8 6481.6 6495.3 6530.8 6535.4 4916.3 4948.3 4962.9 4972.9 4983.2 6627.4 6659.9 6698.4 6714.6 6750.3 6340.9 6392.9 6471.9 6494.9 6535.6 6450.9 6494.0 6500.4 6501.2 6541.4 6255.0 6284.5 6459.3 6465.7 6495.3 6622.4 6684.2 6728.9 6736.9 6741.1 6391.6 6418.3 6445.6 6447.5 6507.6 11:34:59 INFO - PID 14368 | 11:34:59 INFO - PID 14368 | [#5] yui.html Cycles:180 Average:23988.38 Median:20688.79 stddev:32838.09 (158.7%) stddev-sans-first:32884.43 11:34:59 INFO - PID 14368 | Values: 897.9 916.6 917.1 919.7 924.6 17315.7 17590.9 17708.5 17732.2 21427.8 20655.8 21244.6 21350.7 21382.3 21505.8 961.3 977.9 981.9 984.3 985.9 892.4 993.8 993.9 994.3 995.8 1045.3 1050.4 1054.0 1054.9 1056.0 1049.7 1050.6 1051.3 1051.6 1051.8 760.5 762.3 767.2 767.4 769.5 17141.2 17343.0 17478.7 17580.6 17903.4 20247.3 20721.8 21182.6 21364.5 21401.5 16485.4 16530.4 16625.8 16628.8 16641.4 3718.8 3745.2 3746.0 3748.0 3748.1 124478.4 125124.0 125559.0 127408.0 129819.0 16347.7 16369.8 16728.4 16910.2 16956.2 29127.9 30529.1 30623.8 30681.5 30714.4 8003.6 8148.5 8168.3 8171.3 8174.0 4303.6 4364.7 4409.2 4414.2 4415.3 5278.9 5314.0 5357.5 5358.2 5373.7 1113.8 1125.9 1142.5 1150.8 1155.1 684.5 701.6 706.8 711.3 712.2 11890.0 12385.9 12499.6 13271.9 13301.6 693.4 697.3 708.8 721.2 723.4 5484.8 5651.7 5857.9 6410.0 6415.8 106785.5 109714.0 110202.0 116227.4 117806.4 102357.5 104050.0 106263.5 108699.5 110173.4 89595.1 92735.0 93444.5 94930.0 96681.0 11301.5 12138.8 12637.2 13233.9 13411.0 39552.4 40279.4 41019.6 42024.8 42646.4 51631.2 51938.5 52461.0 54838.7 68518.0 18800.0 19141.2 19252.3 19386.6 19497.6 21383.1 22275.1 22370.3 22580.0 22585.8 18007.6 18134.7 19337.4 19519.9 19638.2 19341.1 19472.9 19694.2 19983.6 20041.8 18067.3 18373.7 18387.4 18954.4 19154.1 12528.6 12605.8 12607.2 12693.2 12848.8 13311.0 13603.3 14247.1 14596.9 15061.7 11:34:59 INFO - PID 14368 | -------- Summary: end -------- 11:34:59 INFO - PID 14368 | 11:34:59 INFO - TEST-INFO | 14368: exit 0 11:34:59 INFO - TEST-OK | dromaeo_css | took 1110308ms 11:34:59 INFO - TEST-START | kraken 11:34:59 INFO - Initialising browser for kraken test... 11:34:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33728/getInfo.html -profile /tmp/tmpx_v7dH/profile 11:34:59 INFO - TEST-INFO | started process 14739 (/builds/slave/test/build/application/firefox/firefox http://localhost:33728/getInfo.html) 11:35:04 INFO - TEST-INFO | 14739: exit 0 11:35:04 INFO - Browser initialized. 11:35:04 INFO - Running cycle 1/1 for kraken test... 11:35:04 INFO - Using env: {'DISPLAY': ':0', 11:35:04 INFO - 'HOME': '/home/cltbld', 11:35:04 INFO - 'JSGC_DISABLE_POISONING': '1', 11:35:04 INFO - 'LANG': 'en_US.UTF-8', 11:35:04 INFO - 'LANGUAGE': 'en_US:en', 11:35:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:35:04 INFO - 'LOGNAME': 'cltbld', 11:35:04 INFO - 'MAIL': '/var/mail/cltbld', 11:35:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:04 INFO - 'MOZ_CRASHREPORTER': '1', 11:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:35:04 INFO - 'MOZ_NO_REMOTE': '1', 11:35:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:04 INFO - 'NO_EM_RESTART': '1', 11:35:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:04 INFO - 'PWD': '/builds/slave/test', 11:35:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:04 INFO - 'RUST_BACKTRACE': 'full', 11:35:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:35:04 INFO - 'SHELL': '/bin/bash', 11:35:04 INFO - 'SHLVL': '1', 11:35:04 INFO - 'STYLO_FORCE_ENABLED': '1', 11:35:04 INFO - 'STYLO_THREADS': '1', 11:35:04 INFO - 'TERM': 'linux', 11:35:04 INFO - 'TMOUT': '86400', 11:35:04 INFO - 'USER': 'cltbld', 11:35:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251', 11:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:04 INFO - '_': '/tools/buildbot/bin/python'} 11:35:04 INFO - TEST-INFO | started process 14928 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx_v7dH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:05 INFO - PID 14928 | 11:35:05 INFO - PID 14928 | (/builds/slave/test/build/application/firefox/firefox:14981): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:35:05 INFO - PID 14928 | 11:35:16 INFO - PID 14928 | RSS: Main: 172965888 11:35:16 INFO - PID 14928 | 11:35:18 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:19 INFO - PID 14928 | RSS: Main: 177930240 11:35:19 INFO - PID 14928 | 11:35:22 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-dft) 11:35:22 INFO - PID 14928 | RSS: Main: 178348032 11:35:22 INFO - PID 14928 | 11:35:25 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-fft) 11:35:26 INFO - PID 14928 | RSS: Main: 172773376 11:35:26 INFO - PID 14928 | 11:35:28 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-oscillator) 11:35:29 INFO - PID 14928 | RSS: Main: 173010944 11:35:29 INFO - PID 14928 | 11:35:31 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:32 INFO - PID 14928 | RSS: Main: 173776896 11:35:32 INFO - PID 14928 | 11:35:35 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33728/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:35 INFO - PID 14928 | RSS: Main: 176386048 11:35:35 INFO - PID 14928 | 11:35:39 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33728/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:39 INFO - PID 14928 | RSS: Main: 176271360 11:35:39 INFO - PID 14928 | 11:35:42 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33728/tests/kraken/driver.html?testName=json-parse-financial) 11:35:43 INFO - PID 14928 | RSS: Main: 176599040 11:35:43 INFO - PID 14928 | 11:35:45 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:45 INFO - PID 14928 | RSS: Main: 176123904 11:35:45 INFO - PID 14928 | 11:35:47 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:48 INFO - PID 14928 | RSS: Main: 176746496 11:35:48 INFO - PID 14928 | 11:35:50 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:50 INFO - PID 14928 | RSS: Main: 173080576 11:35:50 INFO - PID 14928 | 11:35:53 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:35:54 INFO - PID 14928 | RSS: Main: 173338624 11:35:54 INFO - PID 14928 | 11:35:57 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:35:57 INFO - PID 14928 | RSS: Main: 173539328 11:35:57 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33728/tests/kraken/driver.html?testName=ai-astar) 11:35:59 INFO - PID 14928 | RSS: Main: 174891008 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | __start_tp_report 11:35:59 INFO - PID 14928 | _x_x_mozilla_page_load 11:35:59 INFO - PID 14928 | _x_x_mozilla_page_load_details 11:35:59 INFO - PID 14928 | |i|pagename|runs| 11:35:59 INFO - PID 14928 | |0;ai-astar;97;107;100;107;105;108;109;100;107;108 11:35:59 INFO - PID 14928 | |1;audio-beat-detection;139;116;140;168;116;146;143;115;174;117 11:35:59 INFO - PID 14928 | |2;audio-dft;162;161;163;161;163;160;160;169;162;163 11:35:59 INFO - PID 14928 | |3;audio-fft;74;73;74;166;74;73;75;89;97;73 11:35:59 INFO - PID 14928 | |4;audio-oscillator;79;79;128;79;78;80;125;80;79;127 11:35:59 INFO - PID 14928 | |5;imaging-gaussian-blur;114;115;114;114;116;114;115;115;113;114 11:35:59 INFO - PID 14928 | |6;imaging-darkroom;148;147;151;150;148;147;149;147;148;147 11:35:59 INFO - PID 14928 | |7;imaging-desaturate;94;93;93;94;93;98;98;98;98;93 11:35:59 INFO - PID 14928 | |8;json-parse-financial;53;58;53;52;52;52;51;51;52;52 11:35:59 INFO - PID 14928 | |9;json-stringify-tinderbox;38;39;39;39;39;38;38;38;43;38 11:35:59 INFO - PID 14928 | |10;stanford-crypto-aes;75;75;73;76;74;75;73;75;74;76 11:35:59 INFO - PID 14928 | |11;stanford-crypto-ccm;123;125;123;129;125;121;125;119;119;171 11:35:59 INFO - PID 14928 | |12;stanford-crypto-pbkdf2;187;175;173;175;179;169;170;171;167;179 11:35:59 INFO - PID 14928 | |13;stanford-crypto-sha256-iterative;63;64;64;74;63;62;62;64;69;65 11:35:59 INFO - PID 14928 | __end_tp_report 11:35:59 INFO - PID 14928 | __start_cc_report 11:35:59 INFO - PID 14928 | _x_x_mozilla_cycle_collect,976 11:35:59 INFO - PID 14928 | __end_cc_report 11:35:59 INFO - PID 14928 | __startTimestamp1504377359807__endTimestamp 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | ------- Summary: start ------- 11:35:59 INFO - PID 14928 | Number of tests: 14 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#0] ai-astar Cycles:10 Average:104.80 Median:107.50 stddev:4.21 (3.9%) stddev-sans-first:3.39 11:35:59 INFO - PID 14928 | Values: 97.0 107.0 100.0 107.0 105.0 108.0 109.0 100.0 107.0 108.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:141.50 stddev:21.67 (15.3%) stddev-sans-first:22.97 11:35:59 INFO - PID 14928 | Values: 139.0 116.0 140.0 168.0 116.0 146.0 143.0 115.0 174.0 117.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:2.59 (1.6%) stddev-sans-first:2.74 11:35:59 INFO - PID 14928 | Values: 162.0 161.0 163.0 161.0 163.0 160.0 160.0 169.0 162.0 163.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#3] audio-fft Cycles:10 Average:86.80 Median:74.00 stddev:29.03 (39.2%) stddev-sans-first:30.42 11:35:59 INFO - PID 14928 | Values: 74.0 73.0 74.0 166.0 74.0 73.0 75.0 89.0 97.0 73.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:79.00 stddev:22.97 (29.1%) stddev-sans-first:23.77 11:35:59 INFO - PID 14928 | Values: 79.0 79.0 128.0 79.0 78.0 80.0 125.0 80.0 79.0 127.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 11:35:59 INFO - PID 14928 | Values: 114.0 115.0 114.0 114.0 116.0 114.0 115.0 115.0 113.0 114.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 11:35:59 INFO - PID 14928 | Values: 148.0 147.0 151.0 150.0 148.0 147.0 149.0 147.0 148.0 147.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:96.00 stddev:2.44 (2.5%) stddev-sans-first:2.55 11:35:59 INFO - PID 14928 | Values: 94.0 93.0 93.0 94.0 93.0 98.0 98.0 98.0 98.0 93.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.00 stddev:2.01 (3.9%) stddev-sans-first:2.13 11:35:59 INFO - PID 14928 | Values: 53.0 58.0 53.0 52.0 52.0 52.0 51.0 51.0 52.0 52.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.52 (3.9%) stddev-sans-first:1.58 11:35:59 INFO - PID 14928 | Values: 38.0 39.0 39.0 39.0 39.0 38.0 38.0 38.0 43.0 38.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 11:35:59 INFO - PID 14928 | Values: 75.0 75.0 73.0 76.0 74.0 75.0 73.0 75.0 74.0 76.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.00 stddev:15.41 (12.3%) stddev-sans-first:16.24 11:35:59 INFO - PID 14928 | Values: 123.0 125.0 123.0 129.0 125.0 121.0 125.0 119.0 119.0 171.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:5.95 (3.4%) stddev-sans-first:4.26 11:35:59 INFO - PID 14928 | Values: 187.0 175.0 173.0 175.0 179.0 169.0 170.0 171.0 167.0 179.0 11:35:59 INFO - PID 14928 | 11:35:59 INFO - PID 14928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.00 stddev:3.74 (5.8%) stddev-sans-first:3.90 11:35:59 INFO - PID 14928 | Values: 63.0 64.0 64.0 74.0 63.0 62.0 62.0 64.0 69.0 65.0 11:35:59 INFO - PID 14928 | -------- Summary: end -------- 11:35:59 INFO - PID 14928 | 11:36:00 INFO - PID 14928 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:36:00 INFO - TEST-INFO | 14928: exit 0 11:36:00 INFO - TEST-OK | kraken | took 60702ms 11:36:00 INFO - SUITE-END | took 1171s 11:36:00 INFO - Completed test suite (00:19:31) 11:36:00 INFO - javascript benchmark 11:36:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8571.720759667645, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3293.3248684019763, 3346.0, 3354.144693103259, 3362.512435696824, 3375.8987230383095, 6355.777547785829, 6450.612963222204, 6478.578892371993, 6511.772087976922, 6558.147440832697, 6312.526560507958, 6373.0, 6390.0, 6390.329015453381, 6410.615363078218, 5737.426257374271, 5738.6556806591525, 5757.769689212448, 5766.481016708495, 5789.739461724233, 5803.8258852234285, 5910.645361278315, 5913.674747888865, 5991.85020374492, 6002.429769171922, 5871.559633027518, 5880.5883588148845, 5961.493273071794, 5998.25021872266, 6064.4541991220785, 5636.0982242841355, 5700.7149642518125, 5842.824715258549, 5848.941510584925, 5977.581569290108, 5594.13290939905, 5685.829425117253, 5776.855578610526, 5849.941500584982, 5900.232969713953, 6332.0, 6459.257185423689, 6461.547691661585, 6517.0224466329955, 6543.214814222276, 6828.214755303154, 6868.793936181923, 6900.6204658743745, 6906.343897329796, 6910.170779506491, 6933.306669333077, 6963.930360696379, 6977.232504424509, 6978.092847929787, 7045.788626341218, 6387.361263873622, 6407.583507072072, 6412.973924172204, 6512.055751915993, 6521.93478065218, 6909.861802763917, 7033.296670332926, 7054.329838665319, 7102.573845569179, 7170.1754298256365, 6639.800805975829, 6642.568233064835, 6644.103046088716, 6650.235222949326, 6654.633995130314, 6668.933310666831, 6752.561083529555, 6754.986751987241, 6764.323567643295, 6764.695588698521, 6722.798316050526, 6827.6244806536115, 6928.237893831674, 6959.791206263821, 6973.79078627642, 6802.455803535705, 6815.795526134224, 6825.1809782825385, 6859.279775623588, 6889.862202755917, 5001.599872010231, 5023.773930173151, 5074.0359331727595, 5114.028334616411, 5117.948820511747, 4356.847510337123, 4417.60241578253, 4475.462944446687, 4546.909061818745, 4567.1550763108935, 6079.817605471843, 6088.11722300264, 6103.877922441527, 6139.693015349215, 6144.41628045335, 6914.274001229899, 6935.133108361455, 6946.37482626566, 7014.964925175444, 7031.8945215821805, 5877.588568800143, 5966.671833049137, 5970.58205925581, 6063.878722425527, 6142.754289828446, 5884.529237661062, 5903.881922361528, 5938.406159384113, 5980.252468441445, 5988.850278743066, 6659.700313485905, 6751.831204219836, 6791.830204244933, 6796.966015169893, 6797.0144329073, 6778.254392016973, 6884.793456196322, 6946.201186863374, 6967.895481567882, 6997.090378250795, 6536.705848236746, 6639.136912201383, 6658.43403310724, 6662.700178492077, 6725.923852183822, 6807.285235050248, 6818.113645226089, 6827.48793840454, 6830.829229269308, 6837.829054273683, 6960.269171737097, 6990.335918087773, 7040.0847889774, 7068.434525237866, 7068.540544864567, 6721.697523611351, 6732.764353247613, 6821.522493425413, 6827.351401616838, 6827.829304267234, 6527.477801775752, 6630.071789949315, 6636.568623039487, 6708.798736037927, 6809.693563789542, 6680.432163266177, 6696.430803381767, 6698.062271282122, 6700.698468569024, 6752.898706519504, 6748.93251067483, 6799.694013769294, 6823.522353435212, 6844.178698556006, 6874.793756187322, 6342.207224096988, 6450.48396128318, 6457.838554036187, 6539.803805885831, 6644.335566443317], "value": 6258.23225383303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.7903387051624, 800.5196881870878, 826.1449399871133, 831.8585840407134, 1116.2242241642061, 30119.84940075299, 30696.232594185156, 30735.692643073562, 39791.60208397915, 40327.19345613093, 39666.0, 39937.20125597486, 40001.19997600046, 40220.79889600548, 40274.59725402745, 7107.147142342926, 7381.520201186932, 7486.925130748705, 7495.138059123216, 7523.811904702399, 7438.144613369451, 7528.284812942789, 7536.397088232929, 7564.0, 7581.0, 7515.812104697399, 7542.35889949355, 7581.431392645546, 7594.848103037936, 7608.239176082375, 7557.924420755805, 7561.810954726121, 7570.583617901013, 7571.77284681455, 7574.507657002332, 7476.626168691544, 7517.812054698622, 7517.887231691474, 7532.133804612485, 7532.698692052311, 35721.28557428863, 35927.281454370765, 36091.0, 36119.81940090309, 36120.81939590311, 3540.0, 3581.033121057326, 3583.4803953426867, 3584.6773790358993, 3586.3185994661194, 30376.696233037608, 30448.54327185094, 30496.847515762278, 30506.0, 30572.0, 5162.974185129088, 5193.169092945149, 5194.402643695986, 5231.450697676765, 5240.554552863011, 184980.0, 185824.07087964608, 186970.0, 187168.0, 187208.0, 46048.0, 46074.769626151654, 46137.76931115323, 46149.30776038362, 46177.0, 48781.26828097581, 48823.0, 48930.26604600934, 48979.51020489821, 49057.50942490529, 15386.9230653846, 15715.842841571666, 15734.763978540332, 15737.44918927855, 15772.369105235663, 11628.767424651629, 11707.239029463057, 12908.806367904488, 13000.0, 13018.349082545836, 13709.245991470365, 13710.38303276355, 13731.725365492834, 13863.653408664864, 13932.721345573033, 5413.404525502192, 5491.28613280271, 5595.209532949499, 5639.379668236491, 5682.602217844711, 990.5493000684671, 1002.3735165521549, 1005.3867141043958, 1008.2992320337441, 1009.2077718990557, 21892.78107218939, 22296.0, 22336.106555737915, 22365.776342236695, 22410.32769016932, 1079.659767733706, 1085.3054045410943, 1099.6096385783092, 1104.9337039777638, 1106.6790630717162, 11913.344766037952, 11980.341081240442, 15437.768433473508, 15533.0, 15735.0, 224773.0, 227736.0, 228096.0, 229047.0, 229834.0, 53394.73302633462, 53856.0, 53921.1911821323, 54069.0, 54252.72873635607, 1422.3101795629111, 1449.6665766873678, 1454.447310022206, 1455.978160327596, 1459.7080583883053, 26082.0, 26626.600600990612, 26643.200703978913, 26705.866470667523, 26793.19620411391, 36287.637123628425, 36443.817780910926, 36750.0, 36779.26441471209, 36799.816000920895, 198622.0, 199190.0, 200336.0, 200452.0, 200518.0, 32772.34455310928, 32903.0, 32986.34027319488, 33283.167920802174, 33343.333133337685, 38773.612263877, 40608.0, 40723.79638101909, 40907.0, 40908.386374203816, 29541.704582954757, 30366.69633303727, 30685.386292274477, 30702.0, 31274.0, 29800.850995744884, 29888.136914818493, 29957.639592262643, 30239.546406804355, 30488.84755576208, 34169.14577135492, 34207.14482137966, 34484.0, 34515.309693806485, 34635.65364346425, 29120.417591647623, 29645.25886852846, 29744.512774360763, 29859.552106718853, 30606.540901886936, 22602.434939126655, 22655.88672056629, 22726.0, 24165.879170604738, 24533.87733061323], "value": 16798.201928495455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.5660541383135, 565.9484369161788, 567.7672154416688, 569.4476357932806, 582.3157789597223, 21395.0, 22089.558208835813, 22099.779002209973, 22164.335069947887, 22885.31344059677, 25094.498110037788, 25387.492250154985, 25586.10448634298, 25594.0, 25607.231783046493, 6548.05053267276, 6693.297203793604, 6695.230048544407, 6696.799096027103, 6700.061991321219, 5778.3643799182055, 6452.257990331102, 6479.254885688136, 6487.545871788977, 6548.0, 6459.224893012822, 6464.0, 6465.224173099211, 6467.385598368171, 6472.190976127984, 6439.967800160993, 6446.806595802133, 6448.64532450715, 6452.967735161341, 6454.903176452357, 5970.940290597126, 5989.161517387569, 5990.0, 5990.8502287442725, 6011.969940150271, 28202.15393538197, 28796.42407151866, 29069.563956540667, 29360.41279174426, 29451.410971780446, 1986.5430950881378, 2017.5561376497294, 2018.6971954206986, 2020.111151093514, 2022.7168196452508, 18502.44492665222, 18998.62002759951, 19030.238790448366, 19042.42872713821, 19060.61878762431, 2415.758424157588, 2424.260600516842, 2475.2697954103583, 2475.7648023437746, 2479.256223133053, 129296.0, 130951.34524327317, 132269.0, 134923.32538337345, 134935.0, 13973.930130349283, 14048.508302209373, 14448.638784030272, 14677.0, 14896.404143834125, 22939.426514337276, 22980.310590681973, 23031.424214394774, 23072.0, 23119.768802312097, 9793.853092203623, 10106.949465252774, 10147.289689721649, 10149.34029288094, 10169.745756356151, 8379.162083791694, 9300.20948219409, 9415.186849326034, 9468.90531094694, 9525.809483810424, 7810.789327654223, 8846.77883052916, 8862.734117976472, 8954.58226278901, 9149.902011758499, 2612.843229406242, 2665.9075472451864, 2687.7446642568925, 2774.6958929303196, 2827.6889542150348, 952.9761755956157, 976.8730065091635, 983.9360441571275, 987.8666380038603, 1007.5717819926502, 19387.612247754965, 19500.02499875029, 19625.411237662895, 20052.298169563994, 23939.28182154538, 1039.875214974208, 1060.9045185933303, 1079.4117206122683, 1083.913286937043, 1095.46322302073, 10932.781344373227, 11059.502322395512, 11524.423778811193, 11524.59663911759, 11576.36330001858, 490411.0, 496138.0, 516810.0, 519259.0, 523239.0, 118223.0, 119156.0, 119691.40154299347, 119779.0, 124169.37915310365, 1237.3627581795383, 1240.8448943882015, 1284.6146156153118, 1285.9099863009687, 1288.491046036829, 20773.0, 21103.683444748032, 21112.0, 21137.260195893068, 21615.135394584042, 55670.72164639151, 57029.71485142548, 57453.71273143608, 59188.0, 60233.096503551606, 66302.33697663154, 66587.0, 66927.3307266921, 67127.99308010482, 67353.32646673471, 14558.636034099232, 14931.701365972836, 14968.550943471713, 15021.849781502482, 15057.77413338779, 23111.537769244856, 23744.762552374945, 23855.52288954246, 23867.761322386556, 23958.281251562483, 18615.813841861407, 18746.812531875054, 18811.05944702732, 19125.521861953563, 19141.808581914003, 16730.24713887902, 17072.231749571052, 17403.390881319094, 17410.39063632767, 17920.91039544794, 18744.906275469082, 19370.12834422426, 19388.12753426071, 19433.54248431345, 19449.611007780048, 14407.855921440652, 14660.193689347188, 14737.631559211106, 14748.525147485165, 14808.62978425548, 18831.6233675323, 18895.905520472308, 19022.7146592804, 19033.238670453025, 19124.71312930335], "value": 12064.40224397878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.927953962532, 1335.1788649980258, 1358.0765079745775, 1360.6054244269162, 1377.5040985245314, 14937.775933360994, 15587.610309742247, 15614.063156210635, 15626.687466250669, 15693.529194124167, 15725.449609263678, 15928.681426371466, 15970.920145399286, 15973.361065557392, 15995.200239987984, 2713.6472258606354, 2763.088180900308, 2823.5623478360885, 2825.3784167483223, 2826.0, 2830.9292267693368, 2855.6287682601233, 2860.556613724876, 2862.957055644167, 2865.169100960719, 2773.320536468568, 2796.0772944928226, 2811.8594070296504, 2849.2164654720013, 2911.577821215933, 2660.0157941561647, 2680.048582753124, 2690.9058182963504, 2694.0840114361113, 2695.8382497050043, 2660.7472290132405, 2680.5175068487665, 2681.2894582935537, 2703.7972152088473, 2712.0236714782664, 14771.482998095122, 14915.403383864632, 14975.0, 14977.550673479813, 14978.700425991528, 8083.636236369378, 8368.0, 8377.078521362646, 8378.622961966727, 8389.790255243606, 5464.562834973192, 5556.305461817273, 5598.804041858556, 5725.08398656213, 5742.712864356808, 1777.2446710148135, 1779.4839496545985, 1802.0719329545295, 1811.3479147506887, 1828.6434145341664, 26751.197464076107, 26828.463430731277, 26914.5962810558, 27055.188344349703, 27091.322716932038, 6483.189601299838, 6723.361280678328, 6929.514933954676, 7064.293570642997, 7230.349268565854, 17287.308507659553, 17328.393506227472, 17354.652906941792, 17375.73936390955, 17393.65212695739, 7931.484453510503, 8141.674333026731, 8144.633491492897, 8180.672773089129, 8236.299914507334, 7462.403007759366, 7476.70093196266, 7597.506162099446, 7622.58075805836, 7665.61671916402, 5209.973950130225, 5372.5970552207955, 5391.32608423947, 5412.702301373383, 5435.809746658927, 1485.851414858527, 1486.2791546100132, 1490.3665941974618, 1490.545383657973, 1506.5103841251637, 879.76246413468, 898.6071589036967, 904.5070436612062, 916.6425094213262, 923.8614207868874, 7800.375969922393, 7836.138024817265, 7889.09275433321, 7918.129005809356, 7957.602119894098, 717.8564287142592, 722.7759394587695, 726.4116065986568, 735.4631119282953, 740.7703611880335, 4744.881377965509, 4786.401699787527, 4797.040591881638, 4877.3903262092235, 4883.902321953541, 21023.8948805255, 21100.261490848054, 22140.778592214192, 22172.445688857584, 22196.223132190295, 21212.469688257916, 21224.469388265417, 21743.23898663539, 21912.561748765253, 21918.342449726533, 10825.350478971286, 10948.890511094947, 11015.504302306415, 11061.5022323994, 11086.16853735973, 8578.142185781371, 8615.3107751381, 8670.393072484865, 8686.913130868863, 8737.21365077146, 17652.646947061243, 18208.0, 18466.907665461586, 18533.53666158357, 18622.255109795457, 18994.905025474785, 19133.617327653646, 19147.521311967314, 19147.61704765869, 19390.515237119183, 11902.226355286879, 12497.437615307515, 12529.248245105322, 12531.18547294423, 12559.686007849878, 14029.3686784097, 14062.156270623795, 14158.221297828306, 14167.716645666822, 14211.289435527975, 10805.621803236849, 10904.400257985886, 10904.7273818152, 11063.778724425627, 11109.500072496596, 11003.944980275048, 11159.107271418105, 11196.608118716133, 11206.663800086011, 11381.0, 9817.754556136153, 9932.205423566242, 9932.304738668225, 9932.702018939442, 9936.602535898483, 7031.507794454339, 7064.752733654297, 7070.964645176947, 7074.575525468488, 7123.750668726777, 7333.413326933725, 7357.632118394166, 7377.446691498052, 7393.852122957618, 7490.550566966], "value": 6671.466473409341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.49234042765744, 507.1454599000683, 531.1846315905086, 537.113762292218, 537.4679067722954, 6329.968350158254, 6336.873262534758, 6388.169537960064, 6448.613083214998, 6465.224173099229, 6051.0, 6133.846653833645, 6194.853952018869, 6286.622802631845, 6326.936730632692, 5038.647294689373, 5041.865580244443, 5056.696598204119, 5078.974605126988, 5090.465501122384, 5083.974580127094, 5087.592992560586, 5099.872503187431, 5107.182850743881, 5121.385433747937, 4815.133276010317, 4918.754062296871, 4977.676451030671, 5037.319961805164, 5056.418511871145, 4899.681520701143, 4935.728534930578, 4983.327250821129, 5000.399952005746, 5033.7734801934, 4413.646908247332, 4437.933430998538, 4439.800208990603, 4442.178197033559, 4481.462224533045, 6122.387761223887, 6152.661603611799, 6202.503799696014, 6213.2233470816145, 6222.439980401786, 5643.8589035274035, 5677.432256774331, 5721.456461636138, 5722.456366645162, 5746.224259724967, 6559.720854433387, 6608.306127856554, 6643.87054200787, 6688.398044175999, 6698.162729658793, 4800.279958006292, 4803.279508073782, 4834.734089625104, 4854.543636908948, 4886.682365646222, 6956.478264130211, 7010.859782804367, 7039.683214255422, 7042.6126563039015, 7043.6478176091505, 5041.395032596039, 5081.0, 5085.0, 5086.262491938722, 5121.539061484485, 5076.289319495274, 5077.974610126926, 5113.284140220372, 5160.845174644766, 5168.715720635401, 5681.403452637496, 5698.233547600257, 5714.314282286069, 5720.42795720433, 5751.741171647286, 6646.501512386493, 6689.13041304637, 6714.832129196711, 6750.1562304711915, 6762.72949082041, 1653.5204790610828, 1752.8422441980283, 1770.4069136839303, 1772.9202185901408, 1794.6321004194108, 1141.7259857634108, 1192.356127691037, 1196.9341686207167, 1208.9758204835855, 1231.3904617214357, 5775.826725198251, 5876.823695289148, 5895.170318247266, 5901.232839730894, 5921.40785921413, 6610.206775186912, 6614.8346291343105, 6626.0966884505115, 6644.700988455531, 6733.966330168318, 5723.427657234243, 5787.0, 5798.391168927286, 5866.413358664185, 5866.472017518444, 3467.8959631211105, 3561.679448849616, 3566.1262990567475, 3572.6427357264583, 3594.155373487228, 6241.0, 6390.84022899422, 6419.0, 6488.448481879093, 6489.935100648933, 6640.169978752656, 6710.1947766267385, 6843.965780171067, 6852.931470685329, 6868.896966545506, 6407.327230640902, 6474.417302442803, 6478.2873883872735, 6501.44737697301, 6527.596566738174, 6573.80278591643, 6620.205575330991, 6678.131842860591, 6693.631850248283, 6716.798496045127, 6638.701258443478, 6651.600903945779, 6677.29888361715, 6679.332066793282, 6700.396964273239, 6467.7736279231885, 6481.578697384655, 6495.253045899782, 6530.771423000172, 6535.411812936859, 4916.287138364989, 4948.331975183304, 4962.875928101682, 4972.930819873744, 4983.227599722049, 6627.436667883284, 6659.900101498384, 6698.430633396021, 6714.563553369016, 6750.257471678014, 6340.9048864268, 6392.93607063942, 6471.902921456088, 6494.902576461452, 6535.640539770358, 6450.903236451363, 6494.0, 6500.414962653384, 6501.2198536175965, 6541.378569035934, 6254.967930291451, 6284.465820405317, 6459.289478157305, 6465.741370345134, 6495.271985766084, 6622.437092847162, 6684.197896252481, 6728.899066514105, 6736.8652626946205, 6741.1236539249585, 6391.552591318563, 6418.29398766126, 6445.584774429531, 6447.548671592944, 6507.577007494687], "value": 5071.733376221379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.8742975983359, 916.5966974531206, 917.1333090229733, 919.737874705709, 924.5608336040382, 17315.653686926253, 17590.944543327376, 17708.46874593761, 17732.20205090771, 21427.785722142773, 20655.793442065577, 21244.575108497822, 21350.679739803916, 21382.25162119326, 21505.784942150574, 961.3414810854587, 977.8777652793401, 981.8723565936418, 984.3109823123806, 985.8866230383491, 892.3619611977435, 993.7962717642902, 993.8707967964154, 994.2592768387561, 995.8356871116293, 1045.263089521889, 1050.4485145298702, 1053.984190237147, 1054.9261551691384, 1056.0495554001384, 1049.664107485605, 1050.616524968385, 1051.3113910388709, 1051.5898799468137, 1051.8422236664524, 760.505671313645, 762.3405754022731, 767.2212704105337, 767.4474378447509, 769.5190505933791, 17141.228644711016, 17343.0, 17478.650426991517, 17580.648387032317, 17903.37338193157, 20247.29134480301, 20721.792782072287, 21182.5763484731, 21364.46588835276, 21401.464963376042, 16485.423010194587, 16530.421435249707, 16625.83374166255, 16628.83371166285, 16641.41755038568, 3718.7768733876055, 3745.194783121615, 3746.0, 3747.9625203747887, 3748.0817199785956, 124478.37760811138, 125124.0, 125559.0, 127408.0, 129819.0, 16347.673046539003, 16369.754453683205, 16728.41450549225, 16910.154492275582, 16956.15219239033, 29127.854360728485, 30529.08412747621, 30623.8468807659, 30681.539776903363, 30714.385712285628, 8003.559804210824, 8148.51108933454, 8168.305694015957, 8171.305439037748, 8174.0, 4303.569643035671, 4364.672649551297, 4409.184300904343, 4414.227510185705, 4415.315626077963, 5278.8944221116135, 5313.990341835039, 5357.491038351351, 5358.2498450217, 5373.731313434313, 1113.8050841102774, 1125.859267591551, 1142.457332766929, 1150.827375893606, 1155.1451925575013, 684.4968947823346, 701.6421624971301, 706.8444942112727, 711.3206887422499, 712.2343480758205, 11890.0, 12385.876141238652, 12499.56251531192, 13271.867281327257, 13301.600951971457, 693.4036728413561, 697.264386072688, 708.8157079159456, 721.249900103886, 723.4104205072849, 5484.765927666243, 5651.717414129359, 5857.88284234313, 6410.0, 6415.775447859302, 106785.46607266914, 109714.0, 110202.0, 116227.41886290515, 117806.41096794461, 102357.48821255846, 104050.0, 106263.4686826561, 108699.45650271856, 110173.44913275383, 89595.10404895998, 92735.0, 93444.53277733704, 94930.0, 96681.0, 11301.547938082713, 12138.817917731065, 12637.241765493733, 13233.942203924893, 13411.0, 39552.40671389989, 40279.3958090623, 41019.58980410277, 42024.789876050425, 42646.36030459608, 51631.22553161631, 51938.480615193366, 52461.0, 54838.72580637071, 68518.0, 18800.0, 19141.181587749143, 19252.326168584033, 19386.612267754284, 19497.610047799248, 21383.14467421348, 22275.108995639992, 22370.32889013332, 22580.0, 22585.774142259026, 18007.63984720272, 18134.72797908006, 19337.41987740314, 19519.926404047914, 19638.214471421554, 19341.12964916554, 19472.90263548673, 19694.212231511152, 19983.60032799365, 20041.799582003994, 18067.277308908022, 18373.724394134366, 18387.448376548724, 18954.43136705901, 19154.138063787443, 12528.624141275777, 12605.810912836132, 12607.180533265308, 12693.238405695687, 12848.807267890803, 13311.0, 13603.251821149932, 14247.147870776733, 14596.854031459974, 15061.698766024838], "value": 9242.40765406115, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 107.0, 105.0, 108.0, 109.0, 100.0, 107.0, 108.0], "value": 104.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 116.0, 140.0, 168.0, 116.0, 146.0, 143.0, 115.0, 174.0, 117.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 163.0, 160.0, 160.0, 169.0, 162.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 166.0, 74.0, 73.0, 75.0, 89.0, 97.0, 73.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 128.0, 79.0, 78.0, 80.0, 125.0, 80.0, 79.0, 127.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 116.0, 114.0, 115.0, 115.0, 113.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 151.0, 150.0, 148.0, 147.0, 149.0, 147.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 98.0, 98.0, 98.0, 98.0, 93.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 53.0, 52.0, 52.0, 52.0, 51.0, 51.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 39.0, 39.0, 39.0, 38.0, 38.0, 38.0, 43.0, 38.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 76.0, 74.0, 75.0, 73.0, 75.0, 74.0, 76.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 123.0, 129.0, 125.0, 121.0, 125.0, 119.0, 119.0, 171.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 175.0, 173.0, 175.0, 179.0, 169.0, 170.0, 171.0, 167.0, 179.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 74.0, 63.0, 62.0, 62.0, 64.0, 69.0, 65.0], "value": 65.0, "unit": "score"}]}]} 11:36:01 INFO - Return code: 0 11:36:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:01 INFO - # TBPL SUCCESS # 11:36:01 INFO - Running post-action listener: _package_coverage_data 11:36:01 INFO - Running post-action listener: _resource_record_post_action 11:36:01 INFO - [mozharness: 2017-09-02 18:36:01.121200Z] Finished run-tests step (success) 11:36:01 INFO - Running post-run listener: _resource_record_post_run 11:36:01 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392699904; Read time: 20; Write time: 254820 11:36:01 INFO - TinderboxPrint: CPU usage
13.1% 11:36:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 11:36:01 INFO - TinderboxPrint: I/O write bytes / time
392,699,904 / 254,820 11:36:01 INFO - TinderboxPrint: CPU idle
8,232.0 (86.9%) 11:36:01 INFO - TinderboxPrint: CPU user
1,192.1 (12.6%) 11:36:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:36:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106692608; Read time: 0; Write time: 94232 11:36:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:36:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286007296; Read time: 20; Write time: 160588 11:36:01 INFO - Running post-run listener: _upload_blobber_files 11:36:01 INFO - Blob upload gear active. 11:36:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:01 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 11:36:01 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'] 11:36:01 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 11:36:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:03 INFO - (blobuploader) - INFO - Done attempting. 11:36:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:09 INFO - (blobuploader) - INFO - Done attempting. 11:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:10 INFO - (blobuploader) - INFO - Done attempting. 11:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:11 INFO - (blobuploader) - INFO - Done attempting. 11:36:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:11 INFO - Return code: 0 11:36:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772b29753aec409f567e504427bc124a6e0488107b7d29e27b8eb4e67e578239db0b0a23380c8063a581f21e68d95bf92766ab90d1bcf891786adfb7f187d28d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e2b07e96c0183e0613bf3d8b5f8560c8e69ba03b9744f9c9bda4bdc4eef02983c358415cc386d414c33023ec40082a86a9e717e3ddad4e639fe195c3fc11518", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0501e33880698ef14f83c0da0913d9e64277af205a216fa409dd1bfe0ffcba9d86983c03944f8c5b25459b2b653bf73274d833b6941abd4fa5929355cfff4064", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba3282bc34ac213d6f007a296168a5f709d506e33b6d61a8fb27588f4002e57d60fa9a2f28bf79fa5f2cc87a076d5163c859f3a2f92f0e3cd84d3ca5a4a2123"} 11:36:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:11 INFO - Contents: 11:36:11 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772b29753aec409f567e504427bc124a6e0488107b7d29e27b8eb4e67e578239db0b0a23380c8063a581f21e68d95bf92766ab90d1bcf891786adfb7f187d28d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e2b07e96c0183e0613bf3d8b5f8560c8e69ba03b9744f9c9bda4bdc4eef02983c358415cc386d414c33023ec40082a86a9e717e3ddad4e639fe195c3fc11518", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0501e33880698ef14f83c0da0913d9e64277af205a216fa409dd1bfe0ffcba9d86983c03944f8c5b25459b2b653bf73274d833b6941abd4fa5929355cfff4064", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba3282bc34ac213d6f007a296168a5f709d506e33b6d61a8fb27588f4002e57d60fa9a2f28bf79fa5f2cc87a076d5163c859f3a2f92f0e3cd84d3ca5a4a2123"} 11:36:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:11 INFO - Copying logs to upload dir... 11:36:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.544624 ========= master_lag: -0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-09-02 11:36:11.084446) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:11.091986) ========= 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=1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772b29753aec409f567e504427bc124a6e0488107b7d29e27b8eb4e67e578239db0b0a23380c8063a581f21e68d95bf92766ab90d1bcf891786adfb7f187d28d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e2b07e96c0183e0613bf3d8b5f8560c8e69ba03b9744f9c9bda4bdc4eef02983c358415cc386d414c33023ec40082a86a9e717e3ddad4e639fe195c3fc11518", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0501e33880698ef14f83c0da0913d9e64277af205a216fa409dd1bfe0ffcba9d86983c03944f8c5b25459b2b653bf73274d833b6941abd4fa5929355cfff4064", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba3282bc34ac213d6f007a296168a5f709d506e33b6d61a8fb27588f4002e57d60fa9a2f28bf79fa5f2cc87a076d5163c859f3a2f92f0e3cd84d3ca5a4a2123"} build_url:https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/772b29753aec409f567e504427bc124a6e0488107b7d29e27b8eb4e67e578239db0b0a23380c8063a581f21e68d95bf92766ab90d1bcf891786adfb7f187d28d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e2b07e96c0183e0613bf3d8b5f8560c8e69ba03b9744f9c9bda4bdc4eef02983c358415cc386d414c33023ec40082a86a9e717e3ddad4e639fe195c3fc11518", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0501e33880698ef14f83c0da0913d9e64277af205a216fa409dd1bfe0ffcba9d86983c03944f8c5b25459b2b653bf73274d833b6941abd4fa5929355cfff4064", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba3282bc34ac213d6f007a296168a5f709d506e33b6d61a8fb27588f4002e57d60fa9a2f28bf79fa5f2cc87a076d5163c859f3a2f92f0e3cd84d3ca5a4a2123"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:11.123718) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:11.124048) ========= 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=1f5564757af27664ca02d71f000001b0-1504356355.838565-2012560251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:11.209203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 11:36:11.209527) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 11:36:11.209833) ========= ========= Total master_lag: -0.14 =========