builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1504895488.74 results: success (0) revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.735596) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.736131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.736561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.801970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.802388) ========= 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=d2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-08 11:31:28-- 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% 104M=0s 2017-09-08 11:31:28 (104 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.069200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.893145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.893456) ========= 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=d2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.944379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:28.944948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b --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=d2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-08 11:31:28,995 truncating revision to first 12 chars 2017-09-08 11:31:28,995 Setting DEBUG logging. 2017-09-08 11:31:28,995 attempt 1/10 2017-09-08 11:31:28,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d0288c29165?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-08 11:31:29,317 unpacking tar archive at: mozilla-central-6d0288c29165/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:29.604753) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:29.605079) ========= script_repo_revision: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:29.605500) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:29.606009) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-08 11:31:29.619910) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-08 11:31:29.620254) ========= /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=d2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:29 INFO - MultiFileLogger online at 20170908 11:31:29 in /builds/slave/test 11:31:29 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:31:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:29 INFO - {'append_to_log': False, 11:31:29 INFO - 'base_work_dir': '/builds/slave/test', 11:31:29 INFO - 'blob_upload_branch': 'Firefox', 11:31:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:29 INFO - 'branch': 'Firefox', 11:31:29 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:29 INFO - 'code_coverage': False, 11:31:29 INFO - 'config_files': ('talos/linux_config.py',), 11:31:29 INFO - 'default_actions': ('clobber', 11:31:29 INFO - 'read-buildbot-config', 11:31:29 INFO - 'download-and-extract', 11:31:29 INFO - 'populate-webroot', 11:31:29 INFO - 'create-virtualenv', 11:31:29 INFO - 'install', 11:31:29 INFO - 'setup-mitmproxy', 11:31:29 INFO - 'run-tests'), 11:31:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:29 INFO - 'disable_ccov_upload': False, 11:31:29 INFO - 'disable_stylo': False, 11:31:29 INFO - 'download_minidump_stackwalk': True, 11:31:29 INFO - 'download_symbols': 'ondemand', 11:31:29 INFO - 'enable_stylo': False, 11:31:29 INFO - 'enable_webrender': False, 11:31:29 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:31:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:29 INFO - 'gecko_profile': False, 11:31:29 INFO - 'gecko_profile_interval': 0, 11:31:29 INFO - 'installer_path': 'installer.exe', 11:31:29 INFO - 'log_level': 'info', 11:31:29 INFO - 'log_name': 'talos', 11:31:29 INFO - 'log_to_console': True, 11:31:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:29 INFO - 'opt_config_files': (), 11:31:29 INFO - 'pip_index': False, 11:31:29 INFO - 'suite': 'dromaeojs-e10s', 11:31:29 INFO - 'system_bits': '32', 11:31:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:29 INFO - 'title': 'talos-linux64-ix-043', 11:31:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:29 INFO - 'use_talos_json': True, 11:31:29 INFO - 'verify': 'False', 11:31:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:29 INFO - 'work_dir': 'build'} 11:31:29 INFO - [mozharness: 2017-09-08 18:31:29.815805Z] Running clobber step. 11:31:29 INFO - Running pre-action listener: _resource_record_pre_action 11:31:29 INFO - Running main action method: clobber 11:31:29 INFO - rmtree: /builds/slave/test/build 11:31:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:31 INFO - Running post-action listener: _resource_record_post_action 11:31:31 INFO - [mozharness: 2017-09-08 18:31:31.386094Z] Finished clobber step (success) 11:31:31 INFO - [mozharness: 2017-09-08 18:31:31.386191Z] Running read-buildbot-config step. 11:31:31 INFO - Running pre-action listener: _resource_record_pre_action 11:31:31 INFO - Running main action method: read_buildbot_config 11:31:31 INFO - Using buildbot properties: 11:31:31 INFO - { 11:31:31 INFO - "project": "", 11:31:31 INFO - "product": "firefox", 11:31:31 INFO - "who": "ffxbld@noreply.mozilla.org", 11:31:31 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:31:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:31:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:31:31 INFO - "stage_platform": "linux64-pgo", 11:31:31 INFO - "basedir": "/builds/slave/test", 11:31:31 INFO - "buildnumber": 168, 11:31:31 INFO - "platform": "ubuntu64_hw", 11:31:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:31 INFO - "slavebuilddir": "test", 11:31:31 INFO - "taskId": "N3LJbF-AQGmKLo4GDkTSsA", 11:31:31 INFO - "branch": "mozilla-central", 11:31:31 INFO - "script_repo_revision": "production", 11:31:31 INFO - "revision": "6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b", 11:31:31 INFO - "slavename": "talos-linux64-ix-043", 11:31:31 INFO - "repo_path": "mozilla-central" 11:31:31 INFO - } 11:31:31 INFO - Finding installer, test and symbols from parent task. 11:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N3LJbF-AQGmKLo4GDkTSsA'}, attempt #1 11:31:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N3LJbF-AQGmKLo4GDkTSsA'}, attempt #1 11:31:32 INFO - Task dependencies: OgZg9cF6Svu5yrljIVhrDw 11:31:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw'}, attempt #1 11:31:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2 11:31:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.test_packages.json 11:31:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.crashreporter-symbols.zip 11:31:33 INFO - Running post-action listener: _resource_record_post_action 11:31:33 INFO - [mozharness: 2017-09-08 18:31:33.284964Z] Finished read-buildbot-config step (success) 11:31:33 INFO - [mozharness: 2017-09-08 18:31:33.285181Z] Running download-and-extract step. 11:31:33 INFO - Running pre-action listener: _resource_record_pre_action 11:31:33 INFO - Running main action method: download_and_extract 11:31:33 INFO - mkdir: /builds/slave/test/build/tests 11:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:33 INFO - trying https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.test_packages.json 11:31:33 INFO - Downloading https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:33 INFO - Downloaded 989 bytes. 11:31:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:33 INFO - Using the following test package requirements: 11:31:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:33 INFO - u'common': [u'target.common.tests.zip'], 11:31:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:33 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:33 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:33 INFO - u'target.web-platform.tests.tar.gz'], 11:31:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:31:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.common.tests.zip 11:31:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:33 INFO - Fetch https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.common.tests.zip into memory 11:31:35 INFO - Content-Length response header: 55691575 11:31:35 INFO - Bytes received: 55691575 11:31:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.talos.tests.zip 11:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:31:46 INFO - Fetch https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.talos.tests.zip into memory 11:31:46 INFO - Content-Length response header: 14496665 11:31:46 INFO - Bytes received: 14496665 11:31:47 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:31:47 INFO - trying https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2 11:31:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:31:48 INFO - Downloaded 63565727 bytes. 11:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2 11:31:48 INFO - mkdir: /builds/slave/test/properties 11:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:48 INFO - Contents: 11:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2 11:31:48 INFO - Running post-action listener: _resource_record_post_action 11:31:48 INFO - Running post-action listener: find_tests_for_verification 11:31:48 INFO - Running post-action listener: set_extra_try_arguments 11:31:48 INFO - [mozharness: 2017-09-08 18:31:48.583083Z] Finished download-and-extract step (success) 11:31:48 INFO - [mozharness: 2017-09-08 18:31:48.583313Z] Running populate-webroot step. 11:31:48 INFO - Running pre-action listener: _resource_record_pre_action 11:31:48 INFO - Running main action method: populate_webroot 11:31:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['tresize', 11:31:48 INFO - 'tcanvasmark']}, 11:31:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['dromaeo_css', 11:31:48 INFO - 'kraken']}, 11:31:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'tests': ['damp', 'tps']}, 11:31:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['damp', 'tps']}, 11:31:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['dromaeo_dom']}, 11:31:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:31:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['basic_compositor_video', 11:31:48 INFO - 'glvideo']}, 11:31:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:31:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['ts_paint_webext', 11:31:48 INFO - 'tp5o_webext']}, 11:31:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_many_windows', 11:31:48 INFO - 'sessionrestore_no_auto_restore', 11:31:48 INFO - 'tabpaint']}, 11:31:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_many_windows', 11:31:48 INFO - 'sessionrestore_no_auto_restore', 11:31:48 INFO - 'tabpaint']}, 11:31:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:31:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:31:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['bloom_basic_singleton']}, 11:31:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['bloom_basic']}, 11:31:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:48 INFO - 'tsvgr_opacity', 11:31:48 INFO - 'tart', 11:31:48 INFO - 'tscrollx', 11:31:48 INFO - 'tsvg_static']}, 11:31:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['tsvgx', 11:31:48 INFO - 'tsvgr_opacity', 11:31:48 INFO - 'tart', 11:31:48 INFO - 'tscrollx', 11:31:48 INFO - 'tsvg_static']}, 11:31:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:31:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'talos_options': ['--disable-stylo'], 11:31:48 INFO - 'tests': ['tp5o']}, 11:31:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:48 INFO - 'talos_options': ['--mitmproxy', 11:31:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:48 INFO - '--firstNonBlankPaint'], 11:31:48 INFO - 'tests': ['tp6_google', 11:31:48 INFO - 'tp6_youtube', 11:31:48 INFO - 'tp6_amazon', 11:31:48 INFO - 'tp6_facebook']}, 11:31:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:48 INFO - 'talos_options': ['--disable-stylo', 11:31:48 INFO - '--mitmproxy', 11:31:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:48 INFO - '--firstNonBlankPaint'], 11:31:48 INFO - 'tests': ['tp6_google', 11:31:48 INFO - 'tp6_youtube', 11:31:48 INFO - 'tp6_amazon', 11:31:48 INFO - 'tp6_facebook']}, 11:31:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:48 INFO - 'talos_options': ['--stylo-threads=1', 11:31:48 INFO - '--mitmproxy', 11:31:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:48 INFO - '--firstNonBlankPaint'], 11:31:48 INFO - 'tests': ['tp6_google', 11:31:48 INFO - 'tp6_youtube', 11:31:48 INFO - 'tp6_amazon', 11:31:48 INFO - 'tp6_facebook']}, 11:31:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'talos_options': ['--xperf_path', 11:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:48 INFO - 'tests': ['tp5n']}, 11:31:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:48 INFO - 'talos_options': ['--disable-stylo', 11:31:48 INFO - '--xperf_path', 11:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:48 INFO - 'tests': ['tp5n']}}} 11:31:48 INFO - Running post-action listener: _resource_record_post_action 11:31:48 INFO - [mozharness: 2017-09-08 18:31:48.603107Z] Finished populate-webroot step (success) 11:31:48 INFO - [mozharness: 2017-09-08 18:31:48.603196Z] Running create-virtualenv step. 11:31:48 INFO - Running pre-action listener: _resource_record_pre_action 11:31:48 INFO - Running main action method: create_virtualenv 11:31:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:31:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:31:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:49 INFO - Installing pip...............done. 11:31:49 INFO - Return code: 0 11:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:31:49 INFO - Reading from file tmpfile_stdout 11:31:49 INFO - Output received: 11:31:49 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:31:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:49 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:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:49 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:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:49 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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:31:49 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:31:49 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:31:49 INFO - Using env: {'DISPLAY': ':0', 11:31:49 INFO - 'HOME': '/home/cltbld', 11:31:49 INFO - 'LANG': 'en_US.UTF-8', 11:31:49 INFO - 'LANGUAGE': 'en_US:en', 11:31:49 INFO - 'LOGNAME': 'cltbld', 11:31:49 INFO - 'MAIL': '/var/mail/cltbld', 11:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:49 INFO - 'MOZ_NO_REMOTE': '1', 11:31:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:49 INFO - 'NO_EM_RESTART': '1', 11:31:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:49 INFO - 'PWD': '/builds/slave/test', 11:31:49 INFO - 'SHELL': '/bin/bash', 11:31:49 INFO - 'SHLVL': '1', 11:31:49 INFO - 'TERM': 'linux', 11:31:49 INFO - 'TMOUT': '86400', 11:31:49 INFO - 'USER': 'cltbld', 11:31:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:49 INFO - '_': '/tools/buildbot/bin/python'} 11:31:50 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:31:50 INFO - Downloading/unpacking pip>=1.5 11:31:50 INFO - Running setup.py egg_info for package pip 11:31:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:50 INFO - Installing collected packages: pip 11:31:50 INFO - Found existing installation: pip 1.1 11:31:50 INFO - Uninstalling pip: 11:31:50 INFO - Successfully uninstalled pip 11:31:50 INFO - Running setup.py install for pip 11:31:50 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:50 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:50 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:50 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:31:50 INFO - Successfully installed pip 11:31:50 INFO - Cleaning up... 11:31:50 INFO - Return code: 0 11:31:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:31:50 INFO - Using env: {'DISPLAY': ':0', 11:31:50 INFO - 'HOME': '/home/cltbld', 11:31:50 INFO - 'LANG': 'en_US.UTF-8', 11:31:50 INFO - 'LANGUAGE': 'en_US:en', 11:31:50 INFO - 'LOGNAME': 'cltbld', 11:31:50 INFO - 'MAIL': '/var/mail/cltbld', 11:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:50 INFO - 'MOZ_NO_REMOTE': '1', 11:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:50 INFO - 'NO_EM_RESTART': '1', 11:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:50 INFO - 'PWD': '/builds/slave/test', 11:31:50 INFO - 'SHELL': '/bin/bash', 11:31:50 INFO - 'SHLVL': '1', 11:31:50 INFO - 'TERM': 'linux', 11:31:50 INFO - 'TMOUT': '86400', 11:31:50 INFO - 'USER': 'cltbld', 11:31:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:50 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Downloading/unpacking psutil>=3.1.1 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:52 INFO - Installing collected packages: psutil 11:31:52 INFO - Running setup.py install for psutil 11:31:52 INFO - building 'psutil._psutil_linux' extension 11:31:52 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:31:52 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:31:52 INFO - building 'psutil._psutil_posix' extension 11:31:52 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:31:52 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:31:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:52 INFO - Successfully installed psutil 11:31:52 INFO - Cleaning up... 11:31:52 INFO - Return code: 0 11:31:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:31: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:31:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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:31:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:31:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:31:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:31:52 INFO - Using env: {'DISPLAY': ':0', 11:31:52 INFO - 'HOME': '/home/cltbld', 11:31:52 INFO - 'LANG': 'en_US.UTF-8', 11:31:52 INFO - 'LANGUAGE': 'en_US:en', 11:31:52 INFO - 'LOGNAME': 'cltbld', 11:31:52 INFO - 'MAIL': '/var/mail/cltbld', 11:31:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:52 INFO - 'MOZ_NO_REMOTE': '1', 11:31:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:52 INFO - 'NO_EM_RESTART': '1', 11:31:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:52 INFO - 'PWD': '/builds/slave/test', 11:31:52 INFO - 'SHELL': '/bin/bash', 11:31:52 INFO - 'SHLVL': '1', 11:31:52 INFO - 'TERM': 'linux', 11:31:52 INFO - 'TMOUT': '86400', 11:31:52 INFO - 'USER': 'cltbld', 11:31:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:31:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:52 INFO - '_': '/tools/buildbot/bin/python'} 11:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:31:55 INFO - Installing collected packages: mozsystemmonitor 11:31:55 INFO - Running setup.py install for mozsystemmonitor 11:31:56 INFO - Successfully installed mozsystemmonitor 11:31:56 INFO - Cleaning up... 11:31:57 INFO - Return code: 0 11:31:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:31: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:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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', '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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:31: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 jsonschema==2.5.1 11:31:57 INFO - Using env: {'DISPLAY': ':0', 11:31:57 INFO - 'HOME': '/home/cltbld', 11:31:57 INFO - 'LANG': 'en_US.UTF-8', 11:31:57 INFO - 'LANGUAGE': 'en_US:en', 11:31:57 INFO - 'LOGNAME': 'cltbld', 11:31:57 INFO - 'MAIL': '/var/mail/cltbld', 11:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:57 INFO - 'MOZ_NO_REMOTE': '1', 11:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:57 INFO - 'NO_EM_RESTART': '1', 11:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:57 INFO - 'PWD': '/builds/slave/test', 11:31:57 INFO - 'SHELL': '/bin/bash', 11:31:57 INFO - 'SHLVL': '1', 11:31:57 INFO - 'TERM': 'linux', 11:31:57 INFO - 'TMOUT': '86400', 11:31:57 INFO - 'USER': 'cltbld', 11:31:57 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:57 INFO - '_': '/tools/buildbot/bin/python'} 11:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:57 INFO - Downloading/unpacking jsonschema==2.5.1 11:31: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:31: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:31: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:31: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:31:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:59 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:59 INFO - warning: no files found matching '*.txt' 11:31:59 INFO - no previously-included directories found matching 'build' 11:31:59 INFO - no previously-included directories found matching 'dist' 11:31:59 INFO - no previously-included directories found matching '.git*' 11:31:59 INFO - Installing collected packages: jsonschema, functools32 11:31:59 INFO - Running setup.py install for functools32 11:31:59 INFO - warning: no files found matching '*.txt' 11:31:59 INFO - no previously-included directories found matching 'build' 11:31:59 INFO - no previously-included directories found matching 'dist' 11:31:59 INFO - no previously-included directories found matching '.git*' 11:31:59 INFO - Successfully installed jsonschema functools32 11:31:59 INFO - Cleaning up... 11:31:59 INFO - Return code: 0 11:31:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:31: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:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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', '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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:31: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 functools32==3.2.3-2 11:31:59 INFO - Using env: {'DISPLAY': ':0', 11:31:59 INFO - 'HOME': '/home/cltbld', 11:31:59 INFO - 'LANG': 'en_US.UTF-8', 11:31:59 INFO - 'LANGUAGE': 'en_US:en', 11:31:59 INFO - 'LOGNAME': 'cltbld', 11:31:59 INFO - 'MAIL': '/var/mail/cltbld', 11:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:59 INFO - 'MOZ_NO_REMOTE': '1', 11:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:59 INFO - 'NO_EM_RESTART': '1', 11:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:59 INFO - 'PWD': '/builds/slave/test', 11:31:59 INFO - 'SHELL': '/bin/bash', 11:31:59 INFO - 'SHLVL': '1', 11:31:59 INFO - 'TERM': 'linux', 11:31:59 INFO - 'TMOUT': '86400', 11:31:59 INFO - 'USER': 'cltbld', 11:31:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:59 INFO - '_': '/tools/buildbot/bin/python'} 11:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:31:59 INFO - Cleaning up... 11:31:59 INFO - Return code: 0 11:31:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31: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:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31: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:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31: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', '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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:31: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 blobuploader==1.2.4 11:31:59 INFO - Using env: {'DISPLAY': ':0', 11:31:59 INFO - 'HOME': '/home/cltbld', 11:31:59 INFO - 'LANG': 'en_US.UTF-8', 11:31:59 INFO - 'LANGUAGE': 'en_US:en', 11:31:59 INFO - 'LOGNAME': 'cltbld', 11:31:59 INFO - 'MAIL': '/var/mail/cltbld', 11:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:59 INFO - 'MOZ_NO_REMOTE': '1', 11:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:59 INFO - 'NO_EM_RESTART': '1', 11:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:59 INFO - 'PWD': '/builds/slave/test', 11:31:59 INFO - 'SHELL': '/bin/bash', 11:31:59 INFO - 'SHLVL': '1', 11:31:59 INFO - 'TERM': 'linux', 11:31:59 INFO - 'TMOUT': '86400', 11:31:59 INFO - 'USER': 'cltbld', 11:31:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:59 INFO - '_': '/tools/buildbot/bin/python'} 11:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:31: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:31: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:31: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:31: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:32:00 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32: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:32: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:32: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:32: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:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32: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:32: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:32: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:32: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:32:01 INFO - Downloading docopt-0.6.1.tar.gz 11:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:01 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:01 INFO - Running setup.py install for blobuploader 11:32:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:01 INFO - Running setup.py install for requests 11:32:01 INFO - Running setup.py install for docopt 11:32:01 INFO - Successfully installed blobuploader requests docopt 11:32:01 INFO - Cleaning up... 11:32:02 INFO - Return code: 0 11:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:02 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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:32:02 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:32:02 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:32:02 INFO - Using env: {'DISPLAY': ':0', 11:32:02 INFO - 'HOME': '/home/cltbld', 11:32:02 INFO - 'LANG': 'en_US.UTF-8', 11:32:02 INFO - 'LANGUAGE': 'en_US:en', 11:32:02 INFO - 'LOGNAME': 'cltbld', 11:32:02 INFO - 'MAIL': '/var/mail/cltbld', 11:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:02 INFO - 'MOZ_NO_REMOTE': '1', 11:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:02 INFO - 'NO_EM_RESTART': '1', 11:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:02 INFO - 'PWD': '/builds/slave/test', 11:32:02 INFO - 'SHELL': '/bin/bash', 11:32:02 INFO - 'SHLVL': '1', 11:32:02 INFO - 'TERM': 'linux', 11:32:02 INFO - 'TMOUT': '86400', 11:32:02 INFO - 'USER': 'cltbld', 11:32:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:02 INFO - '_': '/tools/buildbot/bin/python'} 11:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:02 INFO - Running setup.py (path:/tmp/pip-WQhhRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:02 INFO - Running setup.py (path:/tmp/pip-ShZ6G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:02 INFO - Running setup.py (path:/tmp/pip-TvWCK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:02 INFO - Running setup.py (path:/tmp/pip-O2KtgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:02 INFO - Running setup.py (path:/tmp/pip-GDCoEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:02 INFO - Running setup.py (path:/tmp/pip-Br0ahS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:02 INFO - Running setup.py (path:/tmp/pip-M8elnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:02 INFO - Running setup.py (path:/tmp/pip-qwUYAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:02 INFO - Running setup.py (path:/tmp/pip-XxewxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:02 INFO - Running setup.py (path:/tmp/pip-UtiO8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:02 INFO - Running setup.py (path:/tmp/pip-IOKfNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:03 INFO - Running setup.py (path:/tmp/pip-x96Ucm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:03 INFO - Running setup.py (path:/tmp/pip-70y5k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:03 INFO - Running setup.py (path:/tmp/pip-oNYMTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:03 INFO - Running setup.py (path:/tmp/pip-uBy97u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:03 INFO - Running setup.py (path:/tmp/pip-pqpprv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:03 INFO - Running setup.py (path:/tmp/pip-gvDcMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:03 INFO - Running setup.py install for manifestparser 11:32:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:03 INFO - Running setup.py install for mozcrash 11:32:03 INFO - Running setup.py install for mozdebug 11:32:03 INFO - Running setup.py install for mozdevice 11:32:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:03 INFO - Running setup.py install for mozfile 11:32:03 INFO - Running setup.py install for mozhttpd 11:32:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for mozinfo 11:32:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for mozInstall 11:32:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for mozleak 11:32:04 INFO - Running setup.py install for mozlog 11:32:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for moznetwork 11:32:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for mozprocess 11:32:04 INFO - Running setup.py install for mozprofile 11:32:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for mozrunner 11:32:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:04 INFO - Running setup.py install for mozscreenshot 11:32:05 INFO - Running setup.py install for moztest 11:32:05 INFO - Running setup.py install for mozversion 11:32:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:05 INFO - Cleaning up... 11:32:05 INFO - Return code: 0 11:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:05 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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:32:05 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:32:05 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:32:05 INFO - Using env: {'DISPLAY': ':0', 11:32:05 INFO - 'HOME': '/home/cltbld', 11:32:05 INFO - 'LANG': 'en_US.UTF-8', 11:32:05 INFO - 'LANGUAGE': 'en_US:en', 11:32:05 INFO - 'LOGNAME': 'cltbld', 11:32:05 INFO - 'MAIL': '/var/mail/cltbld', 11:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:05 INFO - 'MOZ_NO_REMOTE': '1', 11:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:05 INFO - 'NO_EM_RESTART': '1', 11:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:05 INFO - 'PWD': '/builds/slave/test', 11:32:05 INFO - 'SHELL': '/bin/bash', 11:32:05 INFO - 'SHLVL': '1', 11:32:05 INFO - 'TERM': 'linux', 11:32:05 INFO - 'TMOUT': '86400', 11:32:05 INFO - 'USER': 'cltbld', 11:32:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:05 INFO - '_': '/tools/buildbot/bin/python'} 11:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:05 INFO - Running setup.py (path:/tmp/pip-tpFhzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:05 INFO - Running setup.py (path:/tmp/pip-8IDQBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:05 INFO - Running setup.py (path:/tmp/pip-EJwiDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:05 INFO - Running setup.py (path:/tmp/pip-Psgmkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:05 INFO - Running setup.py (path:/tmp/pip-b1Eggf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:05 INFO - Running setup.py (path:/tmp/pip-MQRUlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:05 INFO - Running setup.py (path:/tmp/pip-4LC58k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:05 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:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:05 INFO - Running setup.py (path:/tmp/pip-A5N3rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:06 INFO - Running setup.py (path:/tmp/pip-mbxn03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:06 INFO - Running setup.py (path:/tmp/pip-xgdIQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:06 INFO - Running setup.py (path:/tmp/pip-TIQYrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:06 INFO - Running setup.py (path:/tmp/pip-phwUjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:06 INFO - Running setup.py (path:/tmp/pip-ActYzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:06 INFO - Running setup.py (path:/tmp/pip-4GoS3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:06 INFO - Running setup.py (path:/tmp/pip-39HMaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:06 INFO - Running setup.py (path:/tmp/pip-u1hRln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:06 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:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:06 INFO - Running setup.py (path:/tmp/pip-M1WP0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:06 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:32:06 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:32:06 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:32:06 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:32:06 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:32:06 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:32:06 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:32:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:07 INFO - Downloading blessings-1.6.tar.gz 11:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:07 INFO - Installing collected packages: blessings 11:32:07 INFO - Running setup.py install for blessings 11:32:07 INFO - Successfully installed blessings 11:32:07 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:08 INFO - Reading from file tmpfile_stdout 11:32:08 INFO - Current package versions: 11:32:08 INFO - argparse == 1.2.1 11:32:08 INFO - blessings == 1.6 11:32:08 INFO - blobuploader == 1.2.4 11:32:08 INFO - docopt == 0.6.1 11:32:08 INFO - functools32 == 3.2.3-2 11:32:08 INFO - jsonschema == 2.5.1 11:32:08 INFO - manifestparser == 1.1 11:32:08 INFO - mozInstall == 1.13 11:32:08 INFO - mozcrash == 1.0 11:32:08 INFO - mozdebug == 0.1 11:32:08 INFO - mozdevice == 0.51 11:32:08 INFO - mozfile == 1.2 11:32:08 INFO - mozhttpd == 0.7 11:32:08 INFO - mozinfo == 0.10 11:32:08 INFO - mozleak == 0.1 11:32:08 INFO - mozlog == 3.5 11:32:08 INFO - moznetwork == 0.27 11:32:08 INFO - mozprocess == 0.25 11:32:08 INFO - mozprofile == 0.28 11:32:08 INFO - mozrunner == 6.13 11:32:08 INFO - mozscreenshot == 0.1 11:32:08 INFO - mozsystemmonitor == 0.3 11:32:08 INFO - moztest == 0.8 11:32:08 INFO - mozversion == 1.4 11:32:08 INFO - psutil == 3.1.1 11:32:08 INFO - requests == 1.2.3 11:32:08 INFO - wsgiref == 0.1.2 11:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:08 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:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:08 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:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:08 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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:32:08 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:32:08 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:32:08 INFO - Using env: {'DISPLAY': ':0', 11:32:08 INFO - 'HOME': '/home/cltbld', 11:32:08 INFO - 'LANG': 'en_US.UTF-8', 11:32:08 INFO - 'LANGUAGE': 'en_US:en', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MAIL': '/var/mail/cltbld', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SHLVL': '1', 11:32:08 INFO - 'TERM': 'linux', 11:32:08 INFO - 'TMOUT': '86400', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 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:32:08 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:32: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:32: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:32: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:32: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:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:32:09 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:32:09 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:32:09 INFO - Installing collected packages: simplejson 11:32:09 INFO - Running setup.py install for simplejson 11:32:09 INFO - building 'simplejson._speedups' extension 11:32:09 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:32:10 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:32:10 INFO - Successfully installed simplejson 11:32:10 INFO - Cleaning up... 11:32:10 INFO - Return code: 0 11:32:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:10 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 0x24e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2853a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, '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': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', '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:32:10 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:32:10 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:32:10 INFO - Using env: {'DISPLAY': ':0', 11:32:10 INFO - 'HOME': '/home/cltbld', 11:32:10 INFO - 'LANG': 'en_US.UTF-8', 11:32:10 INFO - 'LANGUAGE': 'en_US:en', 11:32:10 INFO - 'LOGNAME': 'cltbld', 11:32:10 INFO - 'MAIL': '/var/mail/cltbld', 11:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:10 INFO - 'MOZ_NO_REMOTE': '1', 11:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:10 INFO - 'NO_EM_RESTART': '1', 11:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:10 INFO - 'PWD': '/builds/slave/test', 11:32:10 INFO - 'SHELL': '/bin/bash', 11:32:10 INFO - 'SHLVL': '1', 11:32:10 INFO - 'TERM': 'linux', 11:32:10 INFO - 'TMOUT': '86400', 11:32:10 INFO - 'USER': 'cltbld', 11:32:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:10 INFO - '_': '/tools/buildbot/bin/python'} 11:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:10 INFO - Cleaning up... 11:32:10 INFO - Return code: 0 11:32:10 INFO - Running post-action listener: _resource_record_post_action 11:32:10 INFO - Running post-action listener: _start_resource_monitoring 11:32:10 INFO - Starting resource monitoring. 11:32:10 INFO - [mozharness: 2017-09-08 18:32:10.951533Z] Finished create-virtualenv step (success) 11:32:10 INFO - [mozharness: 2017-09-08 18:32:10.952008Z] Running install step. 11:32:10 INFO - Running pre-action listener: _resource_record_pre_action 11:32:10 INFO - Running main action method: install 11:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:11 INFO - Reading from file tmpfile_stdout 11:32:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:11 INFO - Reading from file tmpfile_stdout 11:32:11 INFO - Output received: 11:32:11 INFO - Usage: mozinstall [options] installer 11:32:11 INFO - Options: 11:32:11 INFO - -h, --help show this help message and exit 11:32:11 INFO - -d DEST, --destination=DEST 11:32:11 INFO - Directory to install application into. [default: 11:32:11 INFO - "/builds/slave/test"] 11:32:11 INFO - --app=APP Application being installed. [default: firefox] 11:32:11 INFO - mkdir: /builds/slave/test/build/application 11:32:11 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:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:32:27 INFO - Reading from file tmpfile_stdout 11:32:27 INFO - Output received: 11:32:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:27 INFO - Running post-action listener: _resource_record_post_action 11:32:27 INFO - [mozharness: 2017-09-08 18:32:27.705700Z] Finished install step (success) 11:32:27 INFO - [mozharness: 2017-09-08 18:32:27.705849Z] Running setup-mitmproxy step. 11:32:27 INFO - Running pre-action listener: _resource_record_pre_action 11:32:27 INFO - Running main action method: setup_mitmproxy 11:32:27 INFO - Skipping: mitmproxy is not required 11:32:27 INFO - Running post-action listener: _resource_record_post_action 11:32:27 INFO - [mozharness: 2017-09-08 18:32:27.706374Z] Finished setup-mitmproxy step (success) 11:32:27 INFO - [mozharness: 2017-09-08 18:32:27.706475Z] Running run-tests step. 11:32:27 INFO - Running pre-action listener: _resource_record_pre_action 11:32:27 INFO - Running pre-action listener: _set_gcov_prefix 11:32:27 INFO - Running main action method: run_tests 11:32:27 WARNING - Try message not found. 11:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:27 INFO - Python 2.7.3 11:32:27 INFO - Return code: 0 11:32:27 INFO - grabbing minidump binary from tooltool 11:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:27 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 0x2857090>, '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 0x2857d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2851f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:27 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:32:27 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:32:27 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:32:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:27 INFO - Return code: 0 11:32:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:27 INFO - ENV: RUST_BACKTRACE is now full 11:32:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:27 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/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:32:27 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/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:32:27 INFO - Using env: {'DISPLAY': ':0', 11:32:27 INFO - 'HOME': '/home/cltbld', 11:32:27 INFO - 'LANG': 'en_US.UTF-8', 11:32:27 INFO - 'LANGUAGE': 'en_US:en', 11:32:27 INFO - 'LOGNAME': 'cltbld', 11:32:27 INFO - 'MAIL': '/var/mail/cltbld', 11:32:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:27 INFO - 'MOZ_NO_REMOTE': '1', 11:32:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:27 INFO - 'NO_EM_RESTART': '1', 11:32:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:27 INFO - 'PWD': '/builds/slave/test', 11:32:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:27 INFO - 'RUST_BACKTRACE': 'full', 11:32:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:27 INFO - 'SHELL': '/bin/bash', 11:32:27 INFO - 'SHLVL': '1', 11:32:27 INFO - 'TERM': 'linux', 11:32:27 INFO - 'TMOUT': '86400', 11:32:27 INFO - 'USER': 'cltbld', 11:32:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:27 INFO - '_': '/tools/buildbot/bin/python'} 11:32:27 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/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:32:28 INFO - mozversion application_buildid: 20170908171740 11:32:28 INFO - mozversion application_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:32:28 INFO - mozversion application_display_name: Nightly 11:32:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:28 INFO - mozversion application_name: Firefox 11:32:28 INFO - mozversion application_remotingname: firefox 11:32:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:32:28 INFO - mozversion application_vendor: Mozilla 11:32:28 INFO - mozversion application_version: 57.0a1 11:32:28 INFO - mozversion platform_buildid: 20170908171740 11:32:28 INFO - mozversion platform_changeset: 6d0288c291650ab619dc4ff92cb0b60e3b6e7b3b 11:32:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:32:28 INFO - mozversion platform_version: 57.0a1 11:32:28 INFO - using testdate: 1504895548 11:32:28 INFO - actual date: 1504895548 11:32:28 INFO - starting webserver on 'localhost:60430' 11:32:28 INFO - SUITE-START | Running 2 tests 11:32:28 INFO - TEST-START | dromaeo_css 11:32:28 INFO - Initialising browser for dromaeo_css test... 11:32:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60430/getInfo.html -profile /tmp/tmppQciWY/profile 11:32:28 INFO - TEST-INFO | started process 27118 (/builds/slave/test/build/application/firefox/firefox http://localhost:60430/getInfo.html) 11:32:34 INFO - TEST-INFO | 27118: exit 0 11:32:34 INFO - Browser initialized. 11:32:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:34 INFO - Using env: {'DISPLAY': ':0', 11:32:34 INFO - 'HOME': '/home/cltbld', 11:32:34 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:34 INFO - 'LANG': 'en_US.UTF-8', 11:32:34 INFO - 'LANGUAGE': 'en_US:en', 11:32:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:34 INFO - 'LOGNAME': 'cltbld', 11:32:34 INFO - 'MAIL': '/var/mail/cltbld', 11:32:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:34 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:34 INFO - 'MOZ_NO_REMOTE': '1', 11:32:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:34 INFO - 'NO_EM_RESTART': '1', 11:32:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:34 INFO - 'PWD': '/builds/slave/test', 11:32:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:34 INFO - 'RUST_BACKTRACE': 'full', 11:32:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:34 INFO - 'SHELL': '/bin/bash', 11:32:34 INFO - 'SHLVL': '1', 11:32:34 INFO - 'TERM': 'linux', 11:32:34 INFO - 'TMOUT': '86400', 11:32:34 INFO - 'USER': 'cltbld', 11:32:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:34 INFO - '_': '/tools/buildbot/bin/python'} 11:32:34 INFO - TEST-INFO | started process 27321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQciWY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:35 INFO - PID 27321 | 11:32:35 INFO - PID 27321 | (/builds/slave/test/build/application/firefox/firefox:27372): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:35 INFO - PID 27321 | 11:32:45 INFO - PID 27321 | RSS: Main: 163889152 11:32:45 INFO - PID 27321 | 11:35:42 INFO - PID 27321 | Cycle 1(1): loaded http://localhost:60430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60430/tests/dromaeo/cssquery-ext.html) 11:35:43 INFO - PID 27321 | RSS: Main: 167866368 11:35:43 INFO - PID 27321 | 11:38:45 INFO - PID 27321 | Cycle 1(1): loaded http://localhost:60430/tests/dromaeo/cssquery-ext.html (next: http://localhost:60430/tests/dromaeo/cssquery-jquery.html) 11:38:45 INFO - PID 27321 | RSS: Main: 164655104 11:38:45 INFO - PID 27321 | 11:41:47 INFO - PID 27321 | Cycle 1(1): loaded http://localhost:60430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60430/tests/dromaeo/cssquery-mootools.html) 11:41:48 INFO - PID 27321 | RSS: Main: 167673856 11:41:48 INFO - PID 27321 | 11:44:49 INFO - PID 27321 | Cycle 1(1): loaded http://localhost:60430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60430/tests/dromaeo/cssquery-prototype.html) 11:44:50 INFO - PID 27321 | RSS: Main: 165568512 11:44:50 INFO - PID 27321 | 11:47:53 INFO - PID 27321 | Cycle 1(1): loaded http://localhost:60430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60430/tests/dromaeo/cssquery-yui.html) 11:47:53 INFO - PID 27321 | RSS: Main: 166903808 11:47:53 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | Cycle 1(1): loaded http://localhost:60430/tests/dromaeo/cssquery-yui.html (next: http://localhost:60430/tests/dromaeo/cssquery-dojo.html) 11:50:55 INFO - PID 27321 | RSS: Main: 169582592 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | __start_tp_report 11:50:55 INFO - PID 27321 | _x_x_mozilla_page_load 11:50:55 INFO - PID 27321 | _x_x_mozilla_page_load_details 11:50:55 INFO - PID 27321 | |i|pagename|runs| 11:50:55 INFO - PID 27321 | |0;dojo.html;3868.516435445569;3870.825812838422;3891.435741817436;3895.7857317847524;3924.960750392497;6178.351273116315;6225.284092329383;6242.7190776415055;6301.6534090625;6356.52326075545;6293.276273228568;6305.747770089202;6310.49516038717;6321;6357.936420635792;5586.078297080997;5695.231143795586;5698.51562617178;5710.457506536873;5747;177.79385671052808;5681.375048744635;5738.368779434259;5770.798022069229;5781.884362312751;5586.720663966806;5612.579056570774;5615.4665306796;5666.348369937468;5683.801066962677;5613.438656134354;5615.101583746622;5695.829125126253;5697.373288938214;5707.400722924075;5610.915836262459;5612.971935140339;5649.745761440704;5704.828855134353;5705.800296989627;6269.2476902771505;6274.592151510183;6314.210723659543;6366.681665916685;6395.42441180296;6705.664716764142;6804.115464989569;6813.284605116441;6833.077534532824;6926.515143939926;6817.727290908358;6836.145481814773;6840.247572766992;6846.623435711034;6853.588784672886;6210.534209934273;6316.2736285326855;6329.303776584572;6390.073439351315;6398.488120950313;6984.476164287698;6989.440844732511;7060.470464715167;7077.752278670222;7081.114860642419;6561.967190164114;6682.398584127452;6683.565568238049;6780.050792888999;6783.694733736895;6758.290379510081;6833.043373927654;6850.965745171242;6874.175098988154;6916.170059592881;6777.762778302736;6815.727370905108;6835.58986460814;6852.588844669336;6880.139982502187;6718.664066796739;6724.125863637793;6802.523823332319;6826.4538836892925;6836.965815170992;4846.878828029327;4912.263160525949;4993.675411098267;5056.82301119459;5063.569596584258;4517.616002639812;4606.493285738566;4630.953690463052;4641.257398816173;4660.930086048712;6289.276733175652;6366.554341196072;6377.64922929234;6396.968015159894;6403.039544068334;6770.661466926634;6784.050232967388;6793.728250870009;6874.793756187322;6877.243503214642;6232.563720539519;6256.061590761422;6315.305316415191;6319.05214217871;6372.776952806629;5576.442355764391;5579.2746942897165;5587.720613969285;5593.105103183471;5601.411851755507;6856.280090590516;6894.655267236618;6940.6529673516125;7122.109736282965;7140.464465165133;6806.251312355637;6849.931500684929;6856.897146542806;6878.38094571491;6887.6556172190185;7032.964835175791;7035.296470352924;7105.111861017373;7113.466490013167;7139.607321597362;6625.204975402982;6709.127813384229;6710.194776626836;6726.697298621476;6830.521863469509;6692.230393504615;6833.521653484208;6862.519623626298;6865.931340686529;6874.346937040973;6429.357064293533;6618.569792963442;6636.502262330248;6641.966790166019;6658;6540.444062254762;6547.476201903741;6601.702923368364;6608.207015158212;6610.933890661032;6350.904736428864;6437.163168788027;6452.12896258999;6491.870162596627;6541.280459149394;6611.603303801788;6672.366125218096;6675.7997260082275;6693.899591506229;6695.497837662292;6430.5177111715875;6439.967800160969;6450.451711604378;6523.967380163069;6535.836604084746 11:50:55 INFO - PID 27321 | |1;ext.html;882.4616983639978;895.6865097215975;905.5608030105402;906.8141031088627;909.4588719711774;40367.39448908269;44657;44711.32933005999;44795.55204447955;44837;42109.78945105278;42555.36166957498;42631.573684263145;42632.14735705284;42639.57360426395;7237.710491580344;7334.816629584277;7343.742968996086;8210.30212431944;8399.412041157122;8214.34285257181;8288.419810613259;8289.875651865226;8325.333973282153;8326.375521835856;8264.628091735887;8310.335173186131;8313.043999940024;8335.874961875577;8344.624491897848;8154.266116049584;8270.338372930151;8271.710490132846;8279.793005174859;8291.709790157316;8149.062857771313;8203.097659257477;8215.424920255584;8220.095789463154;8241.093479717287;41071.589284107074;41126.79436602798;41370.58629413698;41383.37924931099;41455.7927210365;3774.5281839770028;3816.446615240802;3817.503724515795;3819.1406933439753;3819.598942111066;34798;34947.30105397878;35046.299074018374;35093.29813403718;35132;5459.262999495057;5468.070428027245;5484.177373393983;5526.917096243559;5592.273004509388;219765;220360;220790;221016;221272.9999999984;47886.28170577444;53389.1991620126;53752.73123634435;53805.73097134568;53976.03131827787;50925.490745092815;59527.40472595218;60505.09242361368;60664.69667651722;60819;17124.914375428292;17154.571135721708;17216.483505494856;17263.223154958057;17290;13845.930770346084;13911.30443477822;13914.721705566035;13925.303734813218;13939.721205575832;15657.921710391374;15665.373385064699;15719.292631831595;15730.842691573167;15754.291056902466;6112.205413296332;6184.226971628546;6271.843203919939;6292.685365731695;6304.747810087637;1102.5534658463334;1119.658504156224;1120.2998126171144;1122.6126986189752;1127.3292391027326;25634.359141021625;25664.358391040372;25699.871500642377;25775.48449031009;25831.61252581213;1205.2768338996707;1207.9396030198454;1220.4568966809861;1231.8829711177423;1241.3731065811708;13371.933140334431;13418.865811341957;13435.261060641758;13666.248356340497;13720;288565;288651;288897;289159;289660;61079.69460152671;61233.38766612277;61461;61480.69259653673;61559.076613850826;1499.6727895812066;1549.2331296008547;1564.155356107712;1575.8109026916843;1585.5639699082844;25463.36341591475;25468.872655636602;25491.10641845506;25582.744172558036;25624.359391015372;43328.56671433245;43344.56655433532;43356.56643433651;43470.78264608657;43472.56527434685;245281;245355;245432;245962;246213;37973.62026379811;40072.79963600163;40464.3930341051;40811.38782918318;40964.38553421761;49619.75190124026;49707.751461242464;50252;50599.241011384125;50900.49099509106;37069.4439583401;37123.25753484861;37162;37607.811960940024;37641.81179094087;36680.26639467249;37102.814485927396;37148.62851371452;37383.81308093442;37603;43706.34440483332;43756.78121609372;43975.78012109919;44015.77992110147;44091.77954110337;35551;35696.10759731028;35797.28405431929;36154.8192259037;36762.448563271035;26430.471390572464;26461.867690661424;26527.469450611265;26974.595381068906;27080.864595677685 11:50:55 INFO - PID 27321 | |2;jquery.html;575.712143928036;581.9388964158766;584.3367777572456;586.920765696631;592.5703864698094;23064.538709225806;23634.645480317766;23769.643455348163;23831.76168238315;23877.76122238777;23995;25919.48161036778;26010.479790404228;26236.47527049458;26375.86812065937;6665.200175978889;6857.828554286158;6868.862622747567;6873.896891546631;6875.209350924658;6349.206349206349;6638.50211234157;6678.699458524378;6799.1840979082335;6816.216135144447;6592.80221593353;6598.934010659904;6600.801975940705;6600.9339906601035;6604.075429439882;6591.571547849375;6594.043863639793;6595.439387652055;6599.406053455188;6599.604023758566;5950.672713000783;6164.321924588292;6175.197224360849;6176.166217560662;6177.135201071854;30056.699433005608;30536.236594085327;30567.69432305671;30603.387932241232;30631.693683063106;2250.144944920936;2279.0769738255867;2281.6349384098467;2281.908723651052;2283.075354481438;19925.50186245341;20547.794522054737;20788.688169677465;20813.271535496337;20929.05819238138;2551.693796744384;2574.3435423966766;2597.2597809624167;2609.3607066268696;2624.8162628616005;137578;143834;148685;155977;156085;15047.398104075713;15684.215789210493;15833.050016999017;15935.442259520862;16163.757543636855;24867.875660621943;24876.37809054788;24916.37709057288;24923.127690530746;24985.62521562178;10299.845502317472;10397.324173928822;10526.526306316235;10559.841602375971;10606.257561970742;9614.663486777928;9658.372205806741;9673.758156046155;9682.225421966366;9692.321537492307;9804.901950980398;9909.900900991042;9951.950240248898;9978.550965206583;10027.649032283834;2896.8551572421293;2902.1873875314523;2908.7091290870744;2914.8979785707397;2981.3142977114953;1031.3811712972306;1035.8290882004535;1044.2690116918188;1051.7423231308378;1071.1002757683584;20946.371608851758;21336;21392;21406.25078122258;21595.2441664541;1087.9782404351868;1095.816518160385;1099.6536091131268;1120.3334016260312;1127.4869934179928;11611.664658564374;11640.94179529097;11713.297202167898;11762.529498820122;11781.941090294493;632716;660656;666395;668323;672774;128368;130271;131148;132747.33626331805;134054;1110.9944450277696;1195.318668359027;1233.771752225841;1264.5700461842835;1268.7969924811987;21692.674609881182;21898.781012190313;21899.890500547397;22014;22050.456468047083;65675;65829;66368.33631663621;67665.66167169133;68128.6593567029;79438.20561794308;79846.60076699812;80723.59638201771;82216.58891705504;84960;15108.848911510744;15289.694206115593;15556.144412056992;15586.454474093352;15615.843841561438;24577.877110614332;24588.87705561461;24884.37789055288;24889.751102489467;24891.50216995686;19821.504462388555;20042.198312067354;20159.496012599804;20228.898855505628;20235.19059237673;17515.299388024847;17584.120793959995;17647.558811029827;17768.378106766202;18266;20201.59596808085;20243;20664.896675516527;20687.379378618665;20973;15146.318415671101;15146.924265378602;15275.847241527887;15283.15942623122;15307.77038344448;19148.712769308193;19837.900810495856;19915.10382032783;19951.102200401307;20027.29904453337 11:50:55 INFO - PID 27321 | |3;mootools.html;1449.572376149036;1488.9404423823041;1494.5441640299705;1497.44594500035;1507.5402002389271;16333.346666133355;16876.240569174384;16877.32490700372;16902.5774355641;16943.57641058971;16216.189190540485;16219.756703649426;16369.181540922937;16382.26279817408;16398.426055088046;2842.3036356092784;2850.315924178203;2899.0867876618904;2899.637170529858;2914.184028472031;2752.2018614601843;2780.958285625717;2782.2348854065194;2782.5826126081047;2783.7633801126826;2778.3193117686196;2809.1432113205465;2811.718828117182;2813.8733756980882;2818.8308701477977;2544.669193004907;2582.9741702582924;2596.3379338268714;2606.817522773407;2608.0610980047168;2562.0776520452623;2577.2139497453268;2582.5996970469605;2584.147231413629;2765.834049957009;16760.664786704197;17022.48932532026;17046.914765426092;17051.914740426342;17059;8572.957135214347;8635.309175265964;8844.823103537958;8845.115488451167;8925.196732294125;5393.19102134679;5517.751701173457;5575.024370735146;5597.916031259534;5640.379558248589;2063.8452116091353;2098.8530802843807;2102.6740855167473;2152.13914434226;2160.1899287767087;30061.248468788235;30423.391532169233;30437.086887393412;30493.69506304931;30502.542461862868;7219.00411329303;7294.525855819355;7329.633518324063;7452.813679658052;7516.135644400854;19087.42737717871;19101.713474297896;19172.71240931387;19174.041297935048;19184.80815191858;8406.705765298308;8584.914150858536;8592;8594.35542334315;8597.312215022783;7820.882686759704;7835.608219588998;7842.980412546446;7895.763127106196;7924.683012679428;5240.34495688039;5477.28795256622;5483.533899618577;5547.389787123413;5613.410591887793;1676.1954261954331;1680.8907421017595;1692.61916068886;1696.6691495158573;1707.4792188382662;981.9018098190267;1020.3826684855704;1025.6666583360438;1026.471367245869;1050.8318669013074;8884.555772211364;8936.955315223382;8979.46123232608;8998.370114091951;9072.27421806254;780.1963977103593;807.7778610882054;807.8182408958055;811.9606903163959;823.6622984576295;5256.579473642176;5462.426445223274;5958.702064896738;6058.666773327421;6202.317745048041;24380;24528.509429811304;24539;25086.623700644504;25105.748942510705;24014;24250.393740156283;24832.751672483406;25023.62464563033;25135.24594262175;12203.145779795506;12391.566295179806;12392.876071239352;12537.185082969578;12587.181833180814;9272.072792720674;9524.380915240487;9537.427754334762;9541.522923853918;9620.855687164838;20397.59204815925;20604.484887877323;21091.683624745336;21314.147434102462;21601.567968640855;21542.138314467247;21907.890460547595;22037.66943495881;22086.226982055552;22106.668399973692;11988.400579971141;12255.877441225473;12256.571020014257;12261.69345766363;12272.877271227531;15104.320305586056;15115.697686045998;15246.695066098839;15267;15342.38630454814;11545.59590414365;11557.190996630155;11612;11768.882311176778;11946.104042197045;11665.066794656577;11844.585439509576;11973.281603103493;12123;12229.082818788449;10235.539400726837;10557.102646275152;10589.205809564159;10599.205059620714;10643.946780266358;7322.707091716272;8336.499810011419;8388.538630375388;8453.112423195476;8506.61720222579;7957.482763620346;7980.720674776588;8088.110307866248;8088.9595552021865;8183.099859015384 11:50:55 INFO - PID 27321 | |4;prototype.html;538.8060298292617;552.983410497685;555.1783360626273;573.1460124414623;577.9364269930306;6183.59806612571;6197.938020619792;6199.4110559496885;6217.533684973628;6228.937710622892;6081;6116.5412594055515;6140.2938662053875;6161.661108639023;6179.691015449232;5006.924896126561;5041.72270525121;5044.596432285427;5048.949510504903;5062.8484642593085;5008.248762685608;5018.723970181639;5034.395872495287;5051.1413059779925;5054.747262636872;4955.231939049453;5020.548150666439;5102.387713474388;5109.4379618241965;5141.254518094874;5089.083964886319;5095.8980820383385;5101.438841727407;5104.5661118804765;5123.129068058421;4671.532846715335;4762.452317983441;4783.904321913542;4785.928211076836;4789.616830653539;5844;6025.9096113558335;6059.939620529041;6119.479844213247;6170.259568851721;6020.367861374536;6046.3349031606485;6051.213342265477;6052.273727152769;6071.908921366183;6557.770478033246;6593.208814942238;6638.6680665966505;6681.498887583451;6699.196096468406;5371.274877891474;5372.167314066326;5394.109971854678;5410.972945135289;5445.373782015079;6620;6815.795526134224;6842.521023528355;6842.794716158573;6887.6556172191695;5499.780008799603;5535.114381698909;5544;5578.41426650204;5594.804181853616;5603.775848966077;5611.523020543218;5650.97174514133;5668.603197776199;5677.574181936288;5958.6424814511265;5962.25471816023;5997;6041.577089603686;6071.150038994544;6600.768973085919;6616.96691516549;6664.533482656265;6666;6671.899921501182;1953.189426388033;1967.517958100246;1971.3297478857257;1976.733141025943;1989.9701504477155;1406.7045920356636;1485.3835658201942;1493.133982290269;1496.9027013244104;1508.9924550377177;5997.340292567814;6025.246844144482;6086.904357215743;6158;6209.316975132731;6421.903671444932;6528;6548;6634.50723587189;6656.7670131545165;6055.666938318434;6068.848278792977;6101.725422356005;6178.505719542516;6183.288921774054;3442.913927151791;3451.551298331201;3481.234128491728;3504.7721898076543;3530.541029666127;6784.3554862288;6843.486738494533;6905.896411553831;6907.34380233887;6976.232614412411;6794.93205067943;6825.624590647562;6827.6244806536115;6896.965515172392;7006.194287656985;6864.347886950732;6873.931260687429;6912.827179320457;6962.164540255202;6986.510944233854;6615.254669312181;6621.1392518972225;6685.264620891795;6688.866222675422;6740.797776066725;6578.506612004215;6615.702293396713;6633.834154146185;6645.435138013129;6666.200055993312;6893.310668933267;6903.447724182154;6940.9652951734915;6954.826129346807;6977.33715297046;5568.16477528374;5619.831405057855;5623.718814059199;5626.690532020778;5658.575606829587;6418.679066046772;6535.509836762357;6649.670065986726;6740.359665831738;6745.123133992746;6397.392247736458;6433.967830160819;6441.194850643669;6484.967575162094;6533.901991470037;6328.841778955563;6396.328385519453;6416;6439.3238709934785;6441.391236549205;6254.593451425642;6276.246850377984;6287.905681414691;6398.616083035033;6410.365356833978;6470.676466176767;6475.546711730133;6502.512311576556;6529.869402611826;6589.6375699336995;6255.468285195628;6314.052892066226;6354.4916406686425;6369.87260254783;6386.425221730066 11:50:55 INFO - PID 27321 | |5;yui.html;969.8739163908691;984.3306551544949;1003.4079892863209;1011.2415688233822;1012.8278192707239;18740.812591874077;18986.145623446944;19067;19242.422727318186;23249.418764530896;23207.071717131294;23343.883280583574;23382.41543961402;23391.1813086542;23475.765242347614;1053.8788039375454;1078.7195329214383;1079.4656644960755;1080.287010573022;1080.394978811864;1068.1935138970105;1111.4387234446592;1116.2967330581723;1123.0678536814423;1124.2636073371914;1138.8576427946507;1158.716114551936;1159.9362035088068;1161.3786624156078;1165.5570883064424;1159.2349049627248;1160.901323387513;1161.2800063960315;1161.5295805198907;1163.0811658789546;848.6902280667574;849.9490030598184;851.0383266908354;851.8679604661226;856.2892798976834;21102.366928992156;21203.681944770688;21521.89239053795;21567.892160539097;22111.226107086335;22277.554448911094;22683.206087787014;22929.656055159187;23070.65394019091;23082.42293942648;18426.170822313026;18644;18839.340623078264;18840.623187536174;18843.869367837975;4031.4355990161403;4087.4277601135864;4088.0801819590356;4088.4071809587444;4088.693347998912;158232.20883895623;159124.99999999884;159353;161132;163016;17784.3775467858;18209.08954552267;18330.083495825154;18372.265109395743;18385.356512521998;33726.83136584351;34503.4824477633;34653.82673086618;34719.82640086783;34814;9375.90624093764;9403.059694030542;9431.151196392357;9452.385594936308;9515.952420237854;3976.602339766;4170.749755014648;4599.977000114978;4684.414448193976;4701.95298047022;6647.734090636321;6861.245263021064;6874.8625027500175;6898.103246578014;6926.411255043277;1294.8834604885606;1327.1108357400565;1337.9397927093305;1338.9799153012711;1355.76274152023;711.3277952335097;716.0905649824693;719.4604046964777;723.1358526560815;747.6336595068486;11881.465334059989;12150.878491214975;12507.312097834525;12824.743505129845;13088.934555327352;705.6436499567685;712.4585315160411;719.7804669575829;725.539282555581;726.6366816591704;6122.877542449126;6159.84600384994;6206.658633775095;6214.8135555933395;6259.935810912156;147258;149364;150290;150448.98204071715;154065;127893;132135;132239.3388033073;134023;134852;115221.42389288;115300;115662;116237;117594.41202794103;10798.67603971882;11053.557857685602;11136.49885755159;11247.437628118725;11256.268342557707;56258;56570.717146414005;56672.14991775209;57243.42756572381;57304.71347643235;71881.76532056175;73910;74569.88145177718;75113.62443187748;76124.61937690276;17142.228599713293;17376.652466950844;17429.215685293937;17606.647867042844;17612.823871761117;18725.25098996025;18906.716399253746;18910.905445473236;19023.14395852162;19071.141798619374;16262.918685406497;16355;16405.58986025359;16502.25739841686;16652;15542.84457155414;15620.375184992474;15694.764578531103;15869.52391428259;16063.598410039842;15944.441944531885;16130.67738645244;16208.51374458768;16253;16301.918490407472;13256.337183140997;13342;13461.932690336485;13625.523106691615;13739.931300343434;11538.711532211762;11664.591739289084;11679;11798.528058877891;11882.108841836724 11:50:55 INFO - PID 27321 | __end_tp_report 11:50:55 INFO - PID 27321 | __start_cc_report 11:50:55 INFO - PID 27321 | _x_x_mozilla_cycle_collect,340 11:50:55 INFO - PID 27321 | __end_cc_report 11:50:55 INFO - PID 27321 | __startTimestamp1504896655512__endTimestamp 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | ------- Summary: start ------- 11:50:55 INFO - PID 27321 | Number of tests: 6 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | [#0] dojo.html Cycles:165 Average:6247.42 Median:6491.87 stddev:870.89 (13.4%) stddev-sans-first:853.33 11:50:55 INFO - PID 27321 | Values: 3868.5 3870.8 3891.4 3895.8 3925.0 6178.4 6225.3 6242.7 6301.7 6356.5 6293.3 6305.7 6310.5 6321.0 6357.9 5586.1 5695.2 5698.5 5710.5 5747.0 177.8 5681.4 5738.4 5770.8 5781.9 5586.7 5612.6 5615.5 5666.3 5683.8 5613.4 5615.1 5695.8 5697.4 5707.4 5610.9 5613.0 5649.7 5704.8 5705.8 6269.2 6274.6 6314.2 6366.7 6395.4 6705.7 6804.1 6813.3 6833.1 6926.5 6817.7 6836.1 6840.2 6846.6 6853.6 6210.5 6316.3 6329.3 6390.1 6398.5 6984.5 6989.4 7060.5 7077.8 7081.1 6562.0 6682.4 6683.6 6780.1 6783.7 6758.3 6833.0 6851.0 6874.2 6916.2 6777.8 6815.7 6835.6 6852.6 6880.1 6718.7 6724.1 6802.5 6826.5 6837.0 4846.9 4912.3 4993.7 5056.8 5063.6 4517.6 4606.5 4631.0 4641.3 4660.9 6289.3 6366.6 6377.6 6397.0 6403.0 6770.7 6784.1 6793.7 6874.8 6877.2 6232.6 6256.1 6315.3 6319.1 6372.8 5576.4 5579.3 5587.7 5593.1 5601.4 6856.3 6894.7 6940.7 7122.1 7140.5 6806.3 6849.9 6856.9 6878.4 6887.7 7033.0 7035.3 7105.1 7113.5 7139.6 6625.2 6709.1 6710.2 6726.7 6830.5 6692.2 6833.5 6862.5 6865.9 6874.3 6429.4 6618.6 6636.5 6642.0 6658.0 6540.4 6547.5 6601.7 6608.2 6610.9 6350.9 6437.2 6452.1 6491.9 6541.3 6611.6 6672.4 6675.8 6693.9 6695.5 6430.5 6440.0 6450.5 6524.0 6535.8 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | [#1] ext.html Cycles:180 Average:43828.70 Median:21946.20 stddev:65883.87 (300.2%) stddev-sans-first:65989.78 11:50:55 INFO - PID 27321 | Values: 882.5 895.7 905.6 906.8 909.5 40367.4 44657.0 44711.3 44795.6 44837.0 42109.8 42555.4 42631.6 42632.1 42639.6 7237.7 7334.8 7343.7 8210.3 8399.4 8214.3 8288.4 8289.9 8325.3 8326.4 8264.6 8310.3 8313.0 8335.9 8344.6 8154.3 8270.3 8271.7 8279.8 8291.7 8149.1 8203.1 8215.4 8220.1 8241.1 41071.6 41126.8 41370.6 41383.4 41455.8 3774.5 3816.4 3817.5 3819.1 3819.6 34798.0 34947.3 35046.3 35093.3 35132.0 5459.3 5468.1 5484.2 5526.9 5592.3 219765.0 220360.0 220790.0 221016.0 221273.0 47886.3 53389.2 53752.7 53805.7 53976.0 50925.5 59527.4 60505.1 60664.7 60819.0 17124.9 17154.6 17216.5 17263.2 17290.0 13845.9 13911.3 13914.7 13925.3 13939.7 15657.9 15665.4 15719.3 15730.8 15754.3 6112.2 6184.2 6271.8 6292.7 6304.7 1102.6 1119.7 1120.3 1122.6 1127.3 25634.4 25664.4 25699.9 25775.5 25831.6 1205.3 1207.9 1220.5 1231.9 1241.4 13371.9 13418.9 13435.3 13666.2 13720.0 288565.0 288651.0 288897.0 289159.0 289660.0 61079.7 61233.4 61461.0 61480.7 61559.1 1499.7 1549.2 1564.2 1575.8 1585.6 25463.4 25468.9 25491.1 25582.7 25624.4 43328.6 43344.6 43356.6 43470.8 43472.6 245281.0 245355.0 245432.0 245962.0 246213.0 37973.6 40072.8 40464.4 40811.4 40964.4 49619.8 49707.8 50252.0 50599.2 50900.5 37069.4 37123.3 37162.0 37607.8 37641.8 36680.3 37102.8 37148.6 37383.8 37603.0 43706.3 43756.8 43975.8 44015.8 44091.8 35551.0 35696.1 35797.3 36154.8 36762.4 26430.5 26461.9 26527.5 26974.6 27080.9 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | [#2] jquery.html Cycles:180 Average:41454.15 Median:12673.81 stddev:109883.42 (867.0%) stddev-sans-first:110148.81 11:50:55 INFO - PID 27321 | Values: 575.7 581.9 584.3 586.9 592.6 23064.5 23634.6 23769.6 23831.8 23877.8 23995.0 25919.5 26010.5 26236.5 26375.9 6665.2 6857.8 6868.9 6873.9 6875.2 6349.2 6638.5 6678.7 6799.2 6816.2 6592.8 6598.9 6600.8 6600.9 6604.1 6591.6 6594.0 6595.4 6599.4 6599.6 5950.7 6164.3 6175.2 6176.2 6177.1 30056.7 30536.2 30567.7 30603.4 30631.7 2250.1 2279.1 2281.6 2281.9 2283.1 19925.5 20547.8 20788.7 20813.3 20929.1 2551.7 2574.3 2597.3 2609.4 2624.8 137578.0 143834.0 148685.0 155977.0 156085.0 15047.4 15684.2 15833.1 15935.4 16163.8 24867.9 24876.4 24916.4 24923.1 24985.6 10299.8 10397.3 10526.5 10559.8 10606.3 9614.7 9658.4 9673.8 9682.2 9692.3 9804.9 9909.9 9952.0 9978.6 10027.6 2896.9 2902.2 2908.7 2914.9 2981.3 1031.4 1035.8 1044.3 1051.7 1071.1 20946.4 21336.0 21392.0 21406.3 21595.2 1088.0 1095.8 1099.7 1120.3 1127.5 11611.7 11640.9 11713.3 11762.5 11781.9 632716.0 660656.0 666395.0 668323.0 672774.0 128368.0 130271.0 131148.0 132747.3 134054.0 1111.0 1195.3 1233.8 1264.6 1268.8 21692.7 21898.8 21899.9 22014.0 22050.5 65675.0 65829.0 66368.3 67665.7 68128.7 79438.2 79846.6 80723.6 82216.6 84960.0 15108.8 15289.7 15556.1 15586.5 15615.8 24577.9 24588.9 24884.4 24889.8 24891.5 19821.5 20042.2 20159.5 20228.9 20235.2 17515.3 17584.1 17647.6 17768.4 18266.0 20201.6 20243.0 20664.9 20687.4 20973.0 15146.3 15146.9 15275.8 15283.2 15307.8 19148.7 19837.9 19915.1 19951.1 20027.3 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | [#3] mootools.html Cycles:180 Average:10300.91 Median:2569.65 stddev:7633.85 (297.1%) stddev-sans-first:7626.30 11:50:55 INFO - PID 27321 | Values: 1449.6 1488.9 1494.5 1497.4 1507.5 16333.3 16876.2 16877.3 16902.6 16943.6 16216.2 16219.8 16369.2 16382.3 16398.4 2842.3 2850.3 2899.1 2899.6 2914.2 2752.2 2781.0 2782.2 2782.6 2783.8 2778.3 2809.1 2811.7 2813.9 2818.8 2544.7 2583.0 2596.3 2606.8 2608.1 2562.1 2577.2 2582.6 2584.1 2765.8 16760.7 17022.5 17046.9 17051.9 17059.0 8573.0 8635.3 8844.8 8845.1 8925.2 5393.2 5517.8 5575.0 5597.9 5640.4 2063.8 2098.9 2102.7 2152.1 2160.2 30061.2 30423.4 30437.1 30493.7 30502.5 7219.0 7294.5 7329.6 7452.8 7516.1 19087.4 19101.7 19172.7 19174.0 19184.8 8406.7 8584.9 8592.0 8594.4 8597.3 7820.9 7835.6 7843.0 7895.8 7924.7 5240.3 5477.3 5483.5 5547.4 5613.4 1676.2 1680.9 1692.6 1696.7 1707.5 981.9 1020.4 1025.7 1026.5 1050.8 8884.6 8937.0 8979.5 8998.4 9072.3 780.2 807.8 807.8 812.0 823.7 5256.6 5462.4 5958.7 6058.7 6202.3 24380.0 24528.5 24539.0 25086.6 25105.7 24014.0 24250.4 24832.8 25023.6 25135.2 12203.1 12391.6 12392.9 12537.2 12587.2 9272.1 9524.4 9537.4 9541.5 9620.9 20397.6 20604.5 21091.7 21314.1 21601.6 21542.1 21907.9 22037.7 22086.2 22106.7 11988.4 12255.9 12256.6 12261.7 12272.9 15104.3 15115.7 15246.7 15267.0 15342.4 11545.6 11557.2 11612.0 11768.9 11946.1 11665.1 11844.6 11973.3 12123.0 12229.1 10235.5 10557.1 10589.2 10599.2 10643.9 7322.7 8336.5 8388.5 8453.1 8506.6 7957.5 7980.7 8088.1 8089.0 8183.1 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | [#4] prototype.html Cycles:180 Average:5654.35 Median:6174.38 stddev:1508.99 (24.4%) stddev-sans-first:1463.55 11:50:55 INFO - PID 27321 | Values: 538.8 553.0 555.2 573.1 577.9 6183.6 6197.9 6199.4 6217.5 6228.9 6081.0 6116.5 6140.3 6161.7 6179.7 5006.9 5041.7 5044.6 5048.9 5062.8 5008.2 5018.7 5034.4 5051.1 5054.7 4955.2 5020.5 5102.4 5109.4 5141.3 5089.1 5095.9 5101.4 5104.6 5123.1 4671.5 4762.5 4783.9 4785.9 4789.6 5844.0 6025.9 6059.9 6119.5 6170.3 6020.4 6046.3 6051.2 6052.3 6071.9 6557.8 6593.2 6638.7 6681.5 6699.2 5371.3 5372.2 5394.1 5411.0 5445.4 6620.0 6815.8 6842.5 6842.8 6887.7 5499.8 5535.1 5544.0 5578.4 5594.8 5603.8 5611.5 5651.0 5668.6 5677.6 5958.6 5962.3 5997.0 6041.6 6071.2 6600.8 6617.0 6664.5 6666.0 6671.9 1953.2 1967.5 1971.3 1976.7 1990.0 1406.7 1485.4 1493.1 1496.9 1509.0 5997.3 6025.2 6086.9 6158.0 6209.3 6421.9 6528.0 6548.0 6634.5 6656.8 6055.7 6068.8 6101.7 6178.5 6183.3 3442.9 3451.6 3481.2 3504.8 3530.5 6784.4 6843.5 6905.9 6907.3 6976.2 6794.9 6825.6 6827.6 6897.0 7006.2 6864.3 6873.9 6912.8 6962.2 6986.5 6615.3 6621.1 6685.3 6688.9 6740.8 6578.5 6615.7 6633.8 6645.4 6666.2 6893.3 6903.4 6941.0 6954.8 6977.3 5568.2 5619.8 5623.7 5626.7 5658.6 6418.7 6535.5 6649.7 6740.4 6745.1 6397.4 6434.0 6441.2 6485.0 6533.9 6328.8 6396.3 6416.0 6439.3 6441.4 6254.6 6276.2 6287.9 6398.6 6410.4 6470.7 6475.5 6502.5 6529.9 6589.6 6255.5 6314.1 6354.5 6369.9 6386.4 11:50:55 INFO - PID 27321 | 11:50:55 INFO - PID 27321 | [#5] yui.html Cycles:180 Average:28399.13 Median:18351.17 stddev:42601.36 (232.1%) stddev-sans-first:42671.08 11:50:55 INFO - PID 27321 | Values: 969.9 984.3 1003.4 1011.2 1012.8 18740.8 18986.1 19067.0 19242.4 23249.4 23207.1 23343.9 23382.4 23391.2 23475.8 1053.9 1078.7 1079.5 1080.3 1080.4 1068.2 1111.4 1116.3 1123.1 1124.3 1138.9 1158.7 1159.9 1161.4 1165.6 1159.2 1160.9 1161.3 1161.5 1163.1 848.7 849.9 851.0 851.9 856.3 21102.4 21203.7 21521.9 21567.9 22111.2 22277.6 22683.2 22929.7 23070.7 23082.4 18426.2 18644.0 18839.3 18840.6 18843.9 4031.4 4087.4 4088.1 4088.4 4088.7 158232.2 159125.0 159353.0 161132.0 163016.0 17784.4 18209.1 18330.1 18372.3 18385.4 33726.8 34503.5 34653.8 34719.8 34814.0 9375.9 9403.1 9431.2 9452.4 9516.0 3976.6 4170.7 4600.0 4684.4 4702.0 6647.7 6861.2 6874.9 6898.1 6926.4 1294.9 1327.1 1337.9 1339.0 1355.8 711.3 716.1 719.5 723.1 747.6 11881.5 12150.9 12507.3 12824.7 13088.9 705.6 712.5 719.8 725.5 726.6 6122.9 6159.8 6206.7 6214.8 6259.9 147258.0 149364.0 150290.0 150449.0 154065.0 127893.0 132135.0 132239.3 134023.0 134852.0 115221.4 115300.0 115662.0 116237.0 117594.4 10798.7 11053.6 11136.5 11247.4 11256.3 56258.0 56570.7 56672.1 57243.4 57304.7 71881.8 73910.0 74569.9 75113.6 76124.6 17142.2 17376.7 17429.2 17606.6 17612.8 18725.3 18906.7 18910.9 19023.1 19071.1 16262.9 16355.0 16405.6 16502.3 16652.0 15542.8 15620.4 15694.8 15869.5 16063.6 15944.4 16130.7 16208.5 16253.0 16301.9 13256.3 13342.0 13461.9 13625.5 13739.9 11538.7 11664.6 11679.0 11798.5 11882.1 11:50:55 INFO - PID 27321 | -------- Summary: end -------- 11:50:55 INFO - PID 27321 | 11:50:56 INFO - TEST-INFO | 27321: exit 0 11:50:56 INFO - TEST-OK | dromaeo_css | took 1108129ms 11:50:56 INFO - TEST-START | kraken 11:50:56 INFO - Initialising browser for kraken test... 11:50:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60430/getInfo.html -profile /tmp/tmpXewtot/profile 11:50:56 INFO - TEST-INFO | started process 27700 (/builds/slave/test/build/application/firefox/firefox http://localhost:60430/getInfo.html) 11:51:01 INFO - TEST-INFO | 27700: exit 0 11:51:02 INFO - Browser initialized. 11:51:02 INFO - Running cycle 1/1 for kraken test... 11:51:02 INFO - Using env: {'DISPLAY': ':0', 11:51:02 INFO - 'HOME': '/home/cltbld', 11:51:02 INFO - 'JSGC_DISABLE_POISONING': '1', 11:51:02 INFO - 'LANG': 'en_US.UTF-8', 11:51:02 INFO - 'LANGUAGE': 'en_US:en', 11:51:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:51:02 INFO - 'LOGNAME': 'cltbld', 11:51:02 INFO - 'MAIL': '/var/mail/cltbld', 11:51:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:51:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:51:02 INFO - 'MOZ_CRASHREPORTER': '1', 11:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:51:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:51:02 INFO - 'MOZ_NO_REMOTE': '1', 11:51:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:51:02 INFO - 'NO_EM_RESTART': '1', 11:51:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:51:02 INFO - 'PWD': '/builds/slave/test', 11:51:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:51:02 INFO - 'RUST_BACKTRACE': 'full', 11:51:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:51:02 INFO - 'SHELL': '/bin/bash', 11:51:02 INFO - 'SHLVL': '1', 11:51:02 INFO - 'TERM': 'linux', 11:51:02 INFO - 'TMOUT': '86400', 11:51:02 INFO - 'USER': 'cltbld', 11:51:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143', 11:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:51:02 INFO - '_': '/tools/buildbot/bin/python'} 11:51:02 INFO - TEST-INFO | started process 27902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXewtot/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:02 INFO - PID 27902 | 11:51:02 INFO - PID 27902 | (/builds/slave/test/build/application/firefox/firefox:27953): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:51:02 INFO - PID 27902 | 11:51:13 INFO - PID 27902 | RSS: Main: 163725312 11:51:13 INFO - PID 27902 | 11:51:15 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60430/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:16 INFO - PID 27902 | RSS: Main: 169926656 11:51:16 INFO - PID 27902 | 11:51:19 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60430/tests/kraken/driver.html?testName=audio-dft) 11:51:19 INFO - PID 27902 | RSS: Main: 170573824 11:51:19 INFO - PID 27902 | 11:51:22 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60430/tests/kraken/driver.html?testName=audio-fft) 11:51:23 INFO - PID 27902 | RSS: Main: 164798464 11:51:23 INFO - PID 27902 | 11:51:25 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60430/tests/kraken/driver.html?testName=audio-oscillator) 11:51:26 INFO - PID 27902 | RSS: Main: 165822464 11:51:26 INFO - PID 27902 | 11:51:28 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:28 INFO - PID 27902 | RSS: Main: 166166528 11:51:28 INFO - PID 27902 | 11:51:31 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60430/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:32 INFO - PID 27902 | RSS: Main: 169459712 11:51:32 INFO - PID 27902 | 11:51:36 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60430/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:36 INFO - PID 27902 | RSS: Main: 168714240 11:51:36 INFO - PID 27902 | 11:51:39 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60430/tests/kraken/driver.html?testName=json-parse-financial) 11:51:40 INFO - PID 27902 | RSS: Main: 168484864 11:51:40 INFO - PID 27902 | 11:51:41 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:42 INFO - PID 27902 | RSS: Main: 168509440 11:51:42 INFO - PID 27902 | 11:51:43 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:44 INFO - PID 27902 | RSS: Main: 168640512 11:51:44 INFO - PID 27902 | 11:51:46 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:47 INFO - PID 27902 | RSS: Main: 165826560 11:51:47 INFO - PID 27902 | 11:51:49 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:50 INFO - PID 27902 | RSS: Main: 165613568 11:51:50 INFO - PID 27902 | 11:51:53 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:53 INFO - PID 27902 | RSS: Main: 166256640 11:51:53 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | Cycle 1(1): loaded http://localhost:60430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60430/tests/kraken/driver.html?testName=ai-astar) 11:51:55 INFO - PID 27902 | RSS: Main: 168501248 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | __start_tp_report 11:51:55 INFO - PID 27902 | _x_x_mozilla_page_load 11:51:55 INFO - PID 27902 | _x_x_mozilla_page_load_details 11:51:55 INFO - PID 27902 | |i|pagename|runs| 11:51:55 INFO - PID 27902 | |0;ai-astar;107;106;106;106;105;107;100;105;105;106 11:51:55 INFO - PID 27902 | |1;audio-beat-detection;119;111;111;110;113;139;114;112;114;118 11:51:55 INFO - PID 27902 | |2;audio-dft;163;163;162;162;167;163;161;162;171;168 11:51:55 INFO - PID 27902 | |3;audio-fft;73;74;81;72;73;74;86;73;75;72 11:51:55 INFO - PID 27902 | |4;audio-oscillator;79;77;79;77;79;79;77;78;78;78 11:51:55 INFO - PID 27902 | |5;imaging-gaussian-blur;113;114;113;113;114;115;114;114;113;114 11:51:55 INFO - PID 27902 | |6;imaging-darkroom;149;149;150;149;150;152;152;151;152;150 11:51:55 INFO - PID 27902 | |7;imaging-desaturate;94;94;99;98;99;98;99;99;94;93 11:51:55 INFO - PID 27902 | |8;json-parse-financial;44;43;46;42;44;44;45;43;44;43 11:51:55 INFO - PID 27902 | |9;json-stringify-tinderbox;36;37;36;37;37;36;36;36;36;36 11:51:55 INFO - PID 27902 | |10;stanford-crypto-aes;73;71;74;72;72;74;73;72;72;71 11:51:55 INFO - PID 27902 | |11;stanford-crypto-ccm;118;108;112;107;114;118;128;111;117;125 11:51:55 INFO - PID 27902 | |12;stanford-crypto-pbkdf2;181;167;163;156;154;156;163;155;154;157 11:51:55 INFO - PID 27902 | |13;stanford-crypto-sha256-iterative;59;58;61;61;63;60;59;57;71;62 11:51:55 INFO - PID 27902 | __end_tp_report 11:51:55 INFO - PID 27902 | __start_cc_report 11:51:55 INFO - PID 27902 | _x_x_mozilla_cycle_collect,920 11:51:55 INFO - PID 27902 | __end_cc_report 11:51:55 INFO - PID 27902 | __startTimestamp1504896715697__endTimestamp 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | ------- Summary: start ------- 11:51:55 INFO - PID 27902 | Number of tests: 14 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#0] ai-astar Cycles:10 Average:105.30 Median:106.00 stddev:2.00 (1.9%) stddev-sans-first:2.03 11:51:55 INFO - PID 27902 | Values: 107.0 106.0 106.0 106.0 105.0 107.0 100.0 105.0 105.0 106.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#1] audio-beat-detection Cycles:10 Average:116.10 Median:114.00 stddev:8.57 (7.5%) stddev-sans-first:9.02 11:51:55 INFO - PID 27902 | Values: 119.0 111.0 111.0 110.0 113.0 139.0 114.0 112.0 114.0 118.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:3.29 (2.0%) stddev-sans-first:3.46 11:51:55 INFO - PID 27902 | Values: 163.0 163.0 162.0 162.0 167.0 163.0 161.0 162.0 171.0 168.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#3] audio-fft Cycles:10 Average:75.30 Median:74.00 stddev:4.57 (6.2%) stddev-sans-first:4.77 11:51:55 INFO - PID 27902 | Values: 73.0 74.0 81.0 72.0 73.0 74.0 86.0 73.0 75.0 72.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.50 stddev:0.88 (1.1%) stddev-sans-first:0.87 11:51:55 INFO - PID 27902 | Values: 79.0 77.0 79.0 77.0 79.0 79.0 77.0 78.0 78.0 78.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:51:55 INFO - PID 27902 | Values: 113.0 114.0 113.0 113.0 114.0 115.0 114.0 114.0 113.0 114.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.26 (0.8%) stddev-sans-first:1.24 11:51:55 INFO - PID 27902 | Values: 149.0 149.0 150.0 149.0 150.0 152.0 152.0 151.0 152.0 150.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:98.50 stddev:2.58 (2.6%) stddev-sans-first:2.55 11:51:55 INFO - PID 27902 | Values: 94.0 94.0 99.0 98.0 99.0 98.0 99.0 99.0 94.0 93.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#8] json-parse-financial Cycles:10 Average:43.80 Median:44.00 stddev:1.14 (2.6%) stddev-sans-first:1.20 11:51:55 INFO - PID 27902 | Values: 44.0 43.0 46.0 42.0 44.0 44.0 45.0 43.0 44.0 43.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#9] json-stringify-tinderbox Cycles:10 Average:36.30 Median:36.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 11:51:55 INFO - PID 27902 | Values: 36.0 37.0 36.0 37.0 37.0 36.0 36.0 36.0 36.0 36.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:72.50 stddev:1.07 (1.5%) stddev-sans-first:1.12 11:51:55 INFO - PID 27902 | Values: 73.0 71.0 74.0 72.0 72.0 74.0 73.0 72.0 72.0 71.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:117.50 stddev:6.86 (5.8%) stddev-sans-first:7.23 11:51:55 INFO - PID 27902 | Values: 118.0 108.0 112.0 107.0 114.0 118.0 128.0 111.0 117.0 125.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:160.00 stddev:8.45 (5.3%) stddev-sans-first:4.74 11:51:55 INFO - PID 27902 | Values: 181.0 167.0 163.0 156.0 154.0 156.0 163.0 155.0 154.0 157.0 11:51:55 INFO - PID 27902 | 11:51:55 INFO - PID 27902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:3.93 (6.4%) stddev-sans-first:4.09 11:51:55 INFO - PID 27902 | Values: 59.0 58.0 61.0 61.0 63.0 60.0 59.0 57.0 71.0 62.0 11:51:55 INFO - PID 27902 | -------- Summary: end -------- 11:51:55 INFO - PID 27902 | 11:51:56 INFO - PID 27902 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:51:56 INFO - TEST-INFO | 27902: exit 0 11:51:56 INFO - TEST-OK | kraken | took 60174ms 11:51:56 INFO - SUITE-END | took 1168s 11:51:56 INFO - Completed test suite (00:19:28) 11:51:56 INFO - javascript benchmark 11:51:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9103.839110468929, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3868.516435445569, 3870.825812838422, 3891.435741817436, 3895.7857317847524, 3924.960750392497, 6178.351273116315, 6225.284092329383, 6242.7190776415055, 6301.6534090625, 6356.52326075545, 6293.276273228568, 6305.747770089202, 6310.49516038717, 6321.0, 6357.936420635792, 5586.078297080997, 5695.231143795586, 5698.51562617178, 5710.457506536873, 5747.0, 177.79385671052808, 5681.375048744635, 5738.368779434259, 5770.798022069229, 5781.884362312751, 5586.720663966806, 5612.579056570774, 5615.4665306796, 5666.348369937468, 5683.801066962677, 5613.438656134354, 5615.101583746622, 5695.829125126253, 5697.373288938214, 5707.400722924075, 5610.915836262459, 5612.971935140339, 5649.745761440704, 5704.828855134353, 5705.800296989627, 6269.2476902771505, 6274.592151510183, 6314.210723659543, 6366.681665916685, 6395.42441180296, 6705.664716764142, 6804.115464989569, 6813.284605116441, 6833.077534532824, 6926.515143939926, 6817.727290908358, 6836.145481814773, 6840.247572766992, 6846.623435711034, 6853.588784672886, 6210.534209934273, 6316.2736285326855, 6329.303776584572, 6390.073439351315, 6398.488120950313, 6984.476164287698, 6989.440844732511, 7060.470464715167, 7077.752278670222, 7081.114860642419, 6561.967190164114, 6682.398584127452, 6683.565568238049, 6780.050792888999, 6783.694733736895, 6758.290379510081, 6833.043373927654, 6850.965745171242, 6874.175098988154, 6916.170059592881, 6777.762778302736, 6815.727370905108, 6835.58986460814, 6852.588844669336, 6880.139982502187, 6718.664066796739, 6724.125863637793, 6802.523823332319, 6826.4538836892925, 6836.965815170992, 4846.878828029327, 4912.263160525949, 4993.675411098267, 5056.82301119459, 5063.569596584258, 4517.616002639812, 4606.493285738566, 4630.953690463052, 4641.257398816173, 4660.930086048712, 6289.276733175652, 6366.554341196072, 6377.64922929234, 6396.968015159894, 6403.039544068334, 6770.661466926634, 6784.050232967388, 6793.728250870009, 6874.793756187322, 6877.243503214642, 6232.563720539519, 6256.061590761422, 6315.305316415191, 6319.05214217871, 6372.776952806629, 5576.442355764391, 5579.2746942897165, 5587.720613969285, 5593.105103183471, 5601.411851755507, 6856.280090590516, 6894.655267236618, 6940.6529673516125, 7122.109736282965, 7140.464465165133, 6806.251312355637, 6849.931500684929, 6856.897146542806, 6878.38094571491, 6887.6556172190185, 7032.964835175791, 7035.296470352924, 7105.111861017373, 7113.466490013167, 7139.607321597362, 6625.204975402982, 6709.127813384229, 6710.194776626836, 6726.697298621476, 6830.521863469509, 6692.230393504615, 6833.521653484208, 6862.519623626298, 6865.931340686529, 6874.346937040973, 6429.357064293533, 6618.569792963442, 6636.502262330248, 6641.966790166019, 6658.0, 6540.444062254762, 6547.476201903741, 6601.702923368364, 6608.207015158212, 6610.933890661032, 6350.904736428864, 6437.163168788027, 6452.12896258999, 6491.870162596627, 6541.280459149394, 6611.603303801788, 6672.366125218096, 6675.7997260082275, 6693.899591506229, 6695.497837662292, 6430.5177111715875, 6439.967800160969, 6450.451711604378, 6523.967380163069, 6535.836604084746], "value": 6191.937744837633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.4616983639978, 895.6865097215975, 905.5608030105402, 906.8141031088627, 909.4588719711774, 40367.39448908269, 44657.0, 44711.32933005999, 44795.55204447955, 44837.0, 42109.78945105278, 42555.36166957498, 42631.573684263145, 42632.14735705284, 42639.57360426395, 7237.710491580344, 7334.816629584277, 7343.742968996086, 8210.30212431944, 8399.412041157122, 8214.34285257181, 8288.419810613259, 8289.875651865226, 8325.333973282153, 8326.375521835856, 8264.628091735887, 8310.335173186131, 8313.043999940024, 8335.874961875577, 8344.624491897848, 8154.266116049584, 8270.338372930151, 8271.710490132846, 8279.793005174859, 8291.709790157316, 8149.062857771313, 8203.097659257477, 8215.424920255584, 8220.095789463154, 8241.093479717287, 41071.589284107074, 41126.79436602798, 41370.58629413698, 41383.37924931099, 41455.7927210365, 3774.5281839770028, 3816.446615240802, 3817.503724515795, 3819.1406933439753, 3819.598942111066, 34798.0, 34947.30105397878, 35046.299074018374, 35093.29813403718, 35132.0, 5459.262999495057, 5468.070428027245, 5484.177373393983, 5526.917096243559, 5592.273004509388, 219765.0, 220360.0, 220790.0, 221016.0, 221272.9999999984, 47886.28170577444, 53389.1991620126, 53752.73123634435, 53805.73097134568, 53976.03131827787, 50925.490745092815, 59527.40472595218, 60505.09242361368, 60664.69667651722, 60819.0, 17124.914375428292, 17154.571135721708, 17216.483505494856, 17263.223154958057, 17290.0, 13845.930770346084, 13911.30443477822, 13914.721705566035, 13925.303734813218, 13939.721205575832, 15657.921710391374, 15665.373385064699, 15719.292631831595, 15730.842691573167, 15754.291056902466, 6112.205413296332, 6184.226971628546, 6271.843203919939, 6292.685365731695, 6304.747810087637, 1102.5534658463334, 1119.658504156224, 1120.2998126171144, 1122.6126986189752, 1127.3292391027326, 25634.359141021625, 25664.358391040372, 25699.871500642377, 25775.48449031009, 25831.61252581213, 1205.2768338996707, 1207.9396030198454, 1220.4568966809861, 1231.8829711177423, 1241.3731065811708, 13371.933140334431, 13418.865811341957, 13435.261060641758, 13666.248356340497, 13720.0, 288565.0, 288651.0, 288897.0, 289159.0, 289660.0, 61079.69460152671, 61233.38766612277, 61461.0, 61480.69259653673, 61559.076613850826, 1499.6727895812066, 1549.2331296008547, 1564.155356107712, 1575.8109026916843, 1585.5639699082844, 25463.36341591475, 25468.872655636602, 25491.10641845506, 25582.744172558036, 25624.359391015372, 43328.56671433245, 43344.56655433532, 43356.56643433651, 43470.78264608657, 43472.56527434685, 245281.0, 245355.0, 245432.0, 245962.0, 246213.0, 37973.62026379811, 40072.79963600163, 40464.3930341051, 40811.38782918318, 40964.38553421761, 49619.75190124026, 49707.751461242464, 50252.0, 50599.241011384125, 50900.49099509106, 37069.4439583401, 37123.25753484861, 37162.0, 37607.811960940024, 37641.81179094087, 36680.26639467249, 37102.814485927396, 37148.62851371452, 37383.81308093442, 37603.0, 43706.34440483332, 43756.78121609372, 43975.78012109919, 44015.77992110147, 44091.77954110337, 35551.0, 35696.10759731028, 35797.28405431929, 36154.8192259037, 36762.448563271035, 26430.471390572464, 26461.867690661424, 26527.469450611265, 26974.595381068906, 27080.864595677685], "value": 19064.5905628856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.712143928036, 581.9388964158766, 584.3367777572456, 586.920765696631, 592.5703864698094, 23064.538709225806, 23634.645480317766, 23769.643455348163, 23831.76168238315, 23877.76122238777, 23995.0, 25919.48161036778, 26010.479790404228, 26236.47527049458, 26375.86812065937, 6665.200175978889, 6857.828554286158, 6868.862622747567, 6873.896891546631, 6875.209350924658, 6349.206349206349, 6638.50211234157, 6678.699458524378, 6799.1840979082335, 6816.216135144447, 6592.80221593353, 6598.934010659904, 6600.801975940705, 6600.9339906601035, 6604.075429439882, 6591.571547849375, 6594.043863639793, 6595.439387652055, 6599.406053455188, 6599.604023758566, 5950.672713000783, 6164.321924588292, 6175.197224360849, 6176.166217560662, 6177.135201071854, 30056.699433005608, 30536.236594085327, 30567.69432305671, 30603.387932241232, 30631.693683063106, 2250.144944920936, 2279.0769738255867, 2281.6349384098467, 2281.908723651052, 2283.075354481438, 19925.50186245341, 20547.794522054737, 20788.688169677465, 20813.271535496337, 20929.05819238138, 2551.693796744384, 2574.3435423966766, 2597.2597809624167, 2609.3607066268696, 2624.8162628616005, 137578.0, 143834.0, 148685.0, 155977.0, 156085.0, 15047.398104075713, 15684.215789210493, 15833.050016999017, 15935.442259520862, 16163.757543636855, 24867.875660621943, 24876.37809054788, 24916.37709057288, 24923.127690530746, 24985.62521562178, 10299.845502317472, 10397.324173928822, 10526.526306316235, 10559.841602375971, 10606.257561970742, 9614.663486777928, 9658.372205806741, 9673.758156046155, 9682.225421966366, 9692.321537492307, 9804.901950980398, 9909.900900991042, 9951.950240248898, 9978.550965206583, 10027.649032283834, 2896.8551572421293, 2902.1873875314523, 2908.7091290870744, 2914.8979785707397, 2981.3142977114953, 1031.3811712972306, 1035.8290882004535, 1044.2690116918188, 1051.7423231308378, 1071.1002757683584, 20946.371608851758, 21336.0, 21392.0, 21406.25078122258, 21595.2441664541, 1087.9782404351868, 1095.816518160385, 1099.6536091131268, 1120.3334016260312, 1127.4869934179928, 11611.664658564374, 11640.94179529097, 11713.297202167898, 11762.529498820122, 11781.941090294493, 632716.0, 660656.0, 666395.0, 668323.0, 672774.0, 128368.0, 130271.0, 131148.0, 132747.33626331805, 134054.0, 1110.9944450277696, 1195.318668359027, 1233.771752225841, 1264.5700461842835, 1268.7969924811987, 21692.674609881182, 21898.781012190313, 21899.890500547397, 22014.0, 22050.456468047083, 65675.0, 65829.0, 66368.33631663621, 67665.66167169133, 68128.6593567029, 79438.20561794308, 79846.60076699812, 80723.59638201771, 82216.58891705504, 84960.0, 15108.848911510744, 15289.694206115593, 15556.144412056992, 15586.454474093352, 15615.843841561438, 24577.877110614332, 24588.87705561461, 24884.37789055288, 24889.751102489467, 24891.50216995686, 19821.504462388555, 20042.198312067354, 20159.496012599804, 20228.898855505628, 20235.19059237673, 17515.299388024847, 17584.120793959995, 17647.558811029827, 17768.378106766202, 18266.0, 20201.59596808085, 20243.0, 20664.896675516527, 20687.379378618665, 20973.0, 15146.318415671101, 15146.924265378602, 15275.847241527887, 15283.15942623122, 15307.77038344448, 19148.712769308193, 19837.900810495856, 19915.10382032783, 19951.102200401307, 20027.29904453337], "value": 12852.254353737715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.572376149036, 1488.9404423823041, 1494.5441640299705, 1497.44594500035, 1507.5402002389271, 16333.346666133355, 16876.240569174384, 16877.32490700372, 16902.5774355641, 16943.57641058971, 16216.189190540485, 16219.756703649426, 16369.181540922937, 16382.26279817408, 16398.426055088046, 2842.3036356092784, 2850.315924178203, 2899.0867876618904, 2899.637170529858, 2914.184028472031, 2752.2018614601843, 2780.958285625717, 2782.2348854065194, 2782.5826126081047, 2783.7633801126826, 2778.3193117686196, 2809.1432113205465, 2811.718828117182, 2813.8733756980882, 2818.8308701477977, 2544.669193004907, 2582.9741702582924, 2596.3379338268714, 2606.817522773407, 2608.0610980047168, 2562.0776520452623, 2577.2139497453268, 2582.5996970469605, 2584.147231413629, 2765.834049957009, 16760.664786704197, 17022.48932532026, 17046.914765426092, 17051.914740426342, 17059.0, 8572.957135214347, 8635.309175265964, 8844.823103537958, 8845.115488451167, 8925.196732294125, 5393.19102134679, 5517.751701173457, 5575.024370735146, 5597.916031259534, 5640.379558248589, 2063.8452116091353, 2098.8530802843807, 2102.6740855167473, 2152.13914434226, 2160.1899287767087, 30061.248468788235, 30423.391532169233, 30437.086887393412, 30493.69506304931, 30502.542461862868, 7219.00411329303, 7294.525855819355, 7329.633518324063, 7452.813679658052, 7516.135644400854, 19087.42737717871, 19101.713474297896, 19172.71240931387, 19174.041297935048, 19184.80815191858, 8406.705765298308, 8584.914150858536, 8592.0, 8594.35542334315, 8597.312215022783, 7820.882686759704, 7835.608219588998, 7842.980412546446, 7895.763127106196, 7924.683012679428, 5240.34495688039, 5477.28795256622, 5483.533899618577, 5547.389787123413, 5613.410591887793, 1676.1954261954331, 1680.8907421017595, 1692.61916068886, 1696.6691495158573, 1707.4792188382662, 981.9018098190267, 1020.3826684855704, 1025.6666583360438, 1026.471367245869, 1050.8318669013074, 8884.555772211364, 8936.955315223382, 8979.46123232608, 8998.370114091951, 9072.27421806254, 780.1963977103593, 807.7778610882054, 807.8182408958055, 811.9606903163959, 823.6622984576295, 5256.579473642176, 5462.426445223274, 5958.702064896738, 6058.666773327421, 6202.317745048041, 24380.0, 24528.509429811304, 24539.0, 25086.623700644504, 25105.748942510705, 24014.0, 24250.393740156283, 24832.751672483406, 25023.62464563033, 25135.24594262175, 12203.145779795506, 12391.566295179806, 12392.876071239352, 12537.185082969578, 12587.181833180814, 9272.072792720674, 9524.380915240487, 9537.427754334762, 9541.522923853918, 9620.855687164838, 20397.59204815925, 20604.484887877323, 21091.683624745336, 21314.147434102462, 21601.567968640855, 21542.138314467247, 21907.890460547595, 22037.66943495881, 22086.226982055552, 22106.668399973692, 11988.400579971141, 12255.877441225473, 12256.571020014257, 12261.69345766363, 12272.877271227531, 15104.320305586056, 15115.697686045998, 15246.695066098839, 15267.0, 15342.38630454814, 11545.59590414365, 11557.190996630155, 11612.0, 11768.882311176778, 11946.104042197045, 11665.066794656577, 11844.585439509576, 11973.281603103493, 12123.0, 12229.082818788449, 10235.539400726837, 10557.102646275152, 10589.205809564159, 10599.205059620714, 10643.946780266358, 7322.707091716272, 8336.499810011419, 8388.538630375388, 8453.112423195476, 8506.61720222579, 7957.482763620346, 7980.720674776588, 8088.110307866248, 8088.9595552021865, 8183.099859015384], "value": 7202.473436275983, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.8060298292617, 552.983410497685, 555.1783360626273, 573.1460124414623, 577.9364269930306, 6183.59806612571, 6197.938020619792, 6199.4110559496885, 6217.533684973628, 6228.937710622892, 6081.0, 6116.5412594055515, 6140.2938662053875, 6161.661108639023, 6179.691015449232, 5006.924896126561, 5041.72270525121, 5044.596432285427, 5048.949510504903, 5062.8484642593085, 5008.248762685608, 5018.723970181639, 5034.395872495287, 5051.1413059779925, 5054.747262636872, 4955.231939049453, 5020.548150666439, 5102.387713474388, 5109.4379618241965, 5141.254518094874, 5089.083964886319, 5095.8980820383385, 5101.438841727407, 5104.5661118804765, 5123.129068058421, 4671.532846715335, 4762.452317983441, 4783.904321913542, 4785.928211076836, 4789.616830653539, 5844.0, 6025.9096113558335, 6059.939620529041, 6119.479844213247, 6170.259568851721, 6020.367861374536, 6046.3349031606485, 6051.213342265477, 6052.273727152769, 6071.908921366183, 6557.770478033246, 6593.208814942238, 6638.6680665966505, 6681.498887583451, 6699.196096468406, 5371.274877891474, 5372.167314066326, 5394.109971854678, 5410.972945135289, 5445.373782015079, 6620.0, 6815.795526134224, 6842.521023528355, 6842.794716158573, 6887.6556172191695, 5499.780008799603, 5535.114381698909, 5544.0, 5578.41426650204, 5594.804181853616, 5603.775848966077, 5611.523020543218, 5650.97174514133, 5668.603197776199, 5677.574181936288, 5958.6424814511265, 5962.25471816023, 5997.0, 6041.577089603686, 6071.150038994544, 6600.768973085919, 6616.96691516549, 6664.533482656265, 6666.0, 6671.899921501182, 1953.189426388033, 1967.517958100246, 1971.3297478857257, 1976.733141025943, 1989.9701504477155, 1406.7045920356636, 1485.3835658201942, 1493.133982290269, 1496.9027013244104, 1508.9924550377177, 5997.340292567814, 6025.246844144482, 6086.904357215743, 6158.0, 6209.316975132731, 6421.903671444932, 6528.0, 6548.0, 6634.50723587189, 6656.7670131545165, 6055.666938318434, 6068.848278792977, 6101.725422356005, 6178.505719542516, 6183.288921774054, 3442.913927151791, 3451.551298331201, 3481.234128491728, 3504.7721898076543, 3530.541029666127, 6784.3554862288, 6843.486738494533, 6905.896411553831, 6907.34380233887, 6976.232614412411, 6794.93205067943, 6825.624590647562, 6827.6244806536115, 6896.965515172392, 7006.194287656985, 6864.347886950732, 6873.931260687429, 6912.827179320457, 6962.164540255202, 6986.510944233854, 6615.254669312181, 6621.1392518972225, 6685.264620891795, 6688.866222675422, 6740.797776066725, 6578.506612004215, 6615.702293396713, 6633.834154146185, 6645.435138013129, 6666.200055993312, 6893.310668933267, 6903.447724182154, 6940.9652951734915, 6954.826129346807, 6977.33715297046, 5568.16477528374, 5619.831405057855, 5623.718814059199, 5626.690532020778, 5658.575606829587, 6418.679066046772, 6535.509836762357, 6649.670065986726, 6740.359665831738, 6745.123133992746, 6397.392247736458, 6433.967830160819, 6441.194850643669, 6484.967575162094, 6533.901991470037, 6328.841778955563, 6396.328385519453, 6416.0, 6439.3238709934785, 6441.391236549205, 6254.593451425642, 6276.246850377984, 6287.905681414691, 6398.616083035033, 6410.365356833978, 6470.676466176767, 6475.546711730133, 6502.512311576556, 6529.869402611826, 6589.6375699336995, 6255.468285195628, 6314.052892066226, 6354.4916406686425, 6369.87260254783, 6386.425221730066], "value": 5231.3110868040385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [969.8739163908691, 984.3306551544949, 1003.4079892863209, 1011.2415688233822, 1012.8278192707239, 18740.812591874077, 18986.145623446944, 19067.0, 19242.422727318186, 23249.418764530896, 23207.071717131294, 23343.883280583574, 23382.41543961402, 23391.1813086542, 23475.765242347614, 1053.8788039375454, 1078.7195329214383, 1079.4656644960755, 1080.287010573022, 1080.394978811864, 1068.1935138970105, 1111.4387234446592, 1116.2967330581723, 1123.0678536814423, 1124.2636073371914, 1138.8576427946507, 1158.716114551936, 1159.9362035088068, 1161.3786624156078, 1165.5570883064424, 1159.2349049627248, 1160.901323387513, 1161.2800063960315, 1161.5295805198907, 1163.0811658789546, 848.6902280667574, 849.9490030598184, 851.0383266908354, 851.8679604661226, 856.2892798976834, 21102.366928992156, 21203.681944770688, 21521.89239053795, 21567.892160539097, 22111.226107086335, 22277.554448911094, 22683.206087787014, 22929.656055159187, 23070.65394019091, 23082.42293942648, 18426.170822313026, 18644.0, 18839.340623078264, 18840.623187536174, 18843.869367837975, 4031.4355990161403, 4087.4277601135864, 4088.0801819590356, 4088.4071809587444, 4088.693347998912, 158232.20883895623, 159124.99999999884, 159353.0, 161132.0, 163016.0, 17784.3775467858, 18209.08954552267, 18330.083495825154, 18372.265109395743, 18385.356512521998, 33726.83136584351, 34503.4824477633, 34653.82673086618, 34719.82640086783, 34814.0, 9375.90624093764, 9403.059694030542, 9431.151196392357, 9452.385594936308, 9515.952420237854, 3976.602339766, 4170.749755014648, 4599.977000114978, 4684.414448193976, 4701.95298047022, 6647.734090636321, 6861.245263021064, 6874.8625027500175, 6898.103246578014, 6926.411255043277, 1294.8834604885606, 1327.1108357400565, 1337.9397927093305, 1338.9799153012711, 1355.76274152023, 711.3277952335097, 716.0905649824693, 719.4604046964777, 723.1358526560815, 747.6336595068486, 11881.465334059989, 12150.878491214975, 12507.312097834525, 12824.743505129845, 13088.934555327352, 705.6436499567685, 712.4585315160411, 719.7804669575829, 725.539282555581, 726.6366816591704, 6122.877542449126, 6159.84600384994, 6206.658633775095, 6214.8135555933395, 6259.935810912156, 147258.0, 149364.0, 150290.0, 150448.98204071715, 154065.0, 127893.0, 132135.0, 132239.3388033073, 134023.0, 134852.0, 115221.42389288, 115300.0, 115662.0, 116237.0, 117594.41202794103, 10798.67603971882, 11053.557857685602, 11136.49885755159, 11247.437628118725, 11256.268342557707, 56258.0, 56570.717146414005, 56672.14991775209, 57243.42756572381, 57304.71347643235, 71881.76532056175, 73910.0, 74569.88145177718, 75113.62443187748, 76124.61937690276, 17142.228599713293, 17376.652466950844, 17429.215685293937, 17606.647867042844, 17612.823871761117, 18725.25098996025, 18906.716399253746, 18910.905445473236, 19023.14395852162, 19071.141798619374, 16262.918685406497, 16355.0, 16405.58986025359, 16502.25739841686, 16652.0, 15542.84457155414, 15620.375184992474, 15694.764578531103, 15869.52391428259, 16063.598410039842, 15944.441944531885, 16130.67738645244, 16208.51374458768, 16253.0, 16301.918490407472, 13256.337183140997, 13342.0, 13461.932690336485, 13625.523106691615, 13739.931300343434, 11538.711532211762, 11664.591739289084, 11679.0, 11798.528058877891, 11882.108841836724], "value": 9958.512037911622, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1389.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 106.0, 106.0, 105.0, 107.0, 100.0, 105.0, 105.0, 106.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 111.0, 111.0, 110.0, 113.0, 139.0, 114.0, 112.0, 114.0, 118.0], "value": 116.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 167.0, 163.0, 161.0, 162.0, 171.0, 168.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 81.0, 72.0, 73.0, 74.0, 86.0, 73.0, 75.0, 72.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 79.0, 77.0, 79.0, 79.0, 77.0, 78.0, 78.0, 78.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 149.0, 150.0, 152.0, 152.0, 151.0, 152.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 99.0, 98.0, 99.0, 98.0, 99.0, 99.0, 94.0, 93.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 46.0, 42.0, 44.0, 44.0, 45.0, 43.0, 44.0, 43.0], "value": 43.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 36.0, 37.0, 37.0, 36.0, 36.0, 36.0, 36.0, 36.0], "value": 36.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 74.0, 72.0, 72.0, 74.0, 73.0, 72.0, 72.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 108.0, 112.0, 107.0, 114.0, 118.0, 128.0, 111.0, 117.0, 125.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 167.0, 163.0, 156.0, 154.0, 156.0, 163.0, 155.0, 154.0, 157.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 61.0, 61.0, 63.0, 60.0, 59.0, 57.0, 71.0, 62.0], "value": 61.1, "unit": "score"}]}]} 11:51:56 INFO - Return code: 0 11:51:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:51:56 INFO - # TBPL SUCCESS # 11:51:56 INFO - Running post-action listener: _package_coverage_data 11:51:56 INFO - Running post-action listener: _resource_record_post_action 11:51:56 INFO - [mozharness: 2017-09-08 18:51:56.992437Z] Finished run-tests step (success) 11:51:56 INFO - Running post-run listener: _resource_record_post_run 11:51:57 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292868096; Read time: 16; Write time: 165344 11:51:57 INFO - TinderboxPrint: CPU usage
13.1% 11:51:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:51:57 INFO - TinderboxPrint: I/O write bytes / time
292,868,096 / 165,344 11:51:57 INFO - TinderboxPrint: CPU idle
8,219.8 (86.9%) 11:51:57 INFO - TinderboxPrint: CPU user
1,185.0 (12.5%) 11:51:57 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13152256; Read time: 0; Write time: 1448 11:51:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:51:57 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279638016; Read time: 16; Write time: 163896 11:51:57 INFO - Running post-run listener: _upload_blobber_files 11:51:57 INFO - Blob upload gear active. 11:51:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:57 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:51:57 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:51:57 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:51:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:00 INFO - (blobuploader) - INFO - Done attempting. 11:52:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:52:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:01 INFO - (blobuploader) - INFO - Done attempting. 11:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:08 INFO - (blobuploader) - INFO - Done attempting. 11:52:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:52:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:09 INFO - (blobuploader) - INFO - Done attempting. 11:52:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:09 INFO - Return code: 0 11:52:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:09 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/463d99304561ef1fb21853061fa5026a954cff728aa0437a3934b41cb9bbb81797289bb5e6dd759d0e6e3eb8302e81f88a00ca63acf96c9a6354bd4922acc1dd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f46529efabb6a85e18c9f3569e41cc26ef636daef825c74e9593c87429f7f1fce8d4e5bf0afb94c2efbbf1d929a775cebd00ca463c17a394f159c8d976fc4e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ad9be0f5aa60ef24f88ddae24777eb09245d0431dd02d6e64aaabfa902cbb5cfb4c52ad2a2dabff61315b379e7b5c97359bce683b1a8551bfc85135f8862b4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3928efb591b715e0107c9e08d94a9ec388f7b27db3af13bdcda9133d40cd06ecf6b7f13d23d6f6a2bba92e2306e5ead5b1f910d4369988d2baffc00276f4284"} 11:52:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:09 INFO - Contents: 11:52:09 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/463d99304561ef1fb21853061fa5026a954cff728aa0437a3934b41cb9bbb81797289bb5e6dd759d0e6e3eb8302e81f88a00ca63acf96c9a6354bd4922acc1dd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f46529efabb6a85e18c9f3569e41cc26ef636daef825c74e9593c87429f7f1fce8d4e5bf0afb94c2efbbf1d929a775cebd00ca463c17a394f159c8d976fc4e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ad9be0f5aa60ef24f88ddae24777eb09245d0431dd02d6e64aaabfa902cbb5cfb4c52ad2a2dabff61315b379e7b5c97359bce683b1a8551bfc85135f8862b4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3928efb591b715e0107c9e08d94a9ec388f7b27db3af13bdcda9133d40cd06ecf6b7f13d23d6f6a2bba92e2306e5ead5b1f910d4369988d2baffc00276f4284"} 11:52:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:09 INFO - Copying logs to upload dir... 11:52:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.260326 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-08 11:52:09.915482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:52:09.919638) ========= 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=d2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143 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/463d99304561ef1fb21853061fa5026a954cff728aa0437a3934b41cb9bbb81797289bb5e6dd759d0e6e3eb8302e81f88a00ca63acf96c9a6354bd4922acc1dd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f46529efabb6a85e18c9f3569e41cc26ef636daef825c74e9593c87429f7f1fce8d4e5bf0afb94c2efbbf1d929a775cebd00ca463c17a394f159c8d976fc4e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ad9be0f5aa60ef24f88ddae24777eb09245d0431dd02d6e64aaabfa902cbb5cfb4c52ad2a2dabff61315b379e7b5c97359bce683b1a8551bfc85135f8862b4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3928efb591b715e0107c9e08d94a9ec388f7b27db3af13bdcda9133d40cd06ecf6b7f13d23d6f6a2bba92e2306e5ead5b1f910d4369988d2baffc00276f4284"} build_url:https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/OgZg9cF6Svu5yrljIVhrDw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/463d99304561ef1fb21853061fa5026a954cff728aa0437a3934b41cb9bbb81797289bb5e6dd759d0e6e3eb8302e81f88a00ca63acf96c9a6354bd4922acc1dd", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f46529efabb6a85e18c9f3569e41cc26ef636daef825c74e9593c87429f7f1fce8d4e5bf0afb94c2efbbf1d929a775cebd00ca463c17a394f159c8d976fc4e0", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34ad9be0f5aa60ef24f88ddae24777eb09245d0431dd02d6e64aaabfa902cbb5cfb4c52ad2a2dabff61315b379e7b5c97359bce683b1a8551bfc85135f8862b4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3928efb591b715e0107c9e08d94a9ec388f7b27db3af13bdcda9133d40cd06ecf6b7f13d23d6f6a2bba92e2306e5ead5b1f910d4369988d2baffc00276f4284"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-08 11:52:09.948596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:52:09.948965) ========= 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=d2a8c569965ab8367867b893000001a1-1504895094.502657-1769073143 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-08 11:52:10.034237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:52:10.034568) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-08 11:52:10.034892) ========= ========= Total master_lag: 0.21 =========