builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-008 starttime: 1505350792.48 results: success (0) revision: c15e2f280729b6503f9455cd4448ab2852eb5806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.484146) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.484625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.484938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.501606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.502276) ========= 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=32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-13 17:59:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2017-09-13 17:59:52 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.651185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.651539) ========= 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=32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014268 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:52.701522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 17:59:52.701897) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c15e2f280729b6503f9455cd4448ab2852eb5806 --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 c15e2f280729b6503f9455cd4448ab2852eb5806 --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=32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-13 17:59:52,761 truncating revision to first 12 chars 2017-09-13 17:59:52,761 Setting DEBUG logging. 2017-09-13 17:59:52,761 attempt 1/10 2017-09-13 17:59:52,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c15e2f280729?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-13 17:59:54,166 unpacking tar archive at: mozilla-central-c15e2f280729/testing/mozharness/ program finished with exit code 0 elapsedTime=1.694885 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-13 17:59:54.522333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:54.522671) ========= script_repo_revision: c15e2f280729b6503f9455cd4448ab2852eb5806 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:54.523162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:54.523460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-13 17:59:54.537546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-13 17:59:54.538231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:59:54 INFO - MultiFileLogger online at 20170913 17:59:54 in /builds/slave/test 17:59:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:59:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:59:54 INFO - {'append_to_log': False, 17:59:54 INFO - 'base_work_dir': '/builds/slave/test', 17:59:54 INFO - 'blob_upload_branch': 'Firefox', 17:59:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:59:54 INFO - 'branch': 'Firefox', 17:59:54 INFO - 'buildbot_json_path': 'buildprops.json', 17:59:54 INFO - 'code_coverage': False, 17:59:54 INFO - 'config_files': ('talos/linux_config.py',), 17:59:54 INFO - 'default_actions': ('clobber', 17:59:54 INFO - 'read-buildbot-config', 17:59:54 INFO - 'download-and-extract', 17:59:54 INFO - 'populate-webroot', 17:59:54 INFO - 'create-virtualenv', 17:59:54 INFO - 'install', 17:59:54 INFO - 'setup-mitmproxy', 17:59:54 INFO - 'run-tests'), 17:59:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:59:54 INFO - 'disable_ccov_upload': False, 17:59:54 INFO - 'disable_stylo': False, 17:59:54 INFO - 'download_minidump_stackwalk': True, 17:59:54 INFO - 'download_symbols': 'ondemand', 17:59:54 INFO - 'enable_stylo': False, 17:59:54 INFO - 'enable_webrender': False, 17:59:54 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:59:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:59:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:59:54 INFO - 'gecko_profile': False, 17:59:54 INFO - 'gecko_profile_interval': 0, 17:59:54 INFO - 'installer_path': 'installer.exe', 17:59:54 INFO - 'log_level': 'info', 17:59:54 INFO - 'log_name': 'talos', 17:59:54 INFO - 'log_to_console': True, 17:59:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:59:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:59:54 INFO - 'opt_config_files': (), 17:59:54 INFO - 'pip_index': False, 17:59:54 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:59:54 INFO - 'system_bits': '32', 17:59:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:59:54 INFO - 'title': 'talos-linux64-ix-008', 17:59:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:59:54 INFO - 'use_talos_json': True, 17:59:54 INFO - 'verify': 'False', 17:59:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:59:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:59:54 INFO - 'work_dir': 'build'} 17:59:54 INFO - [mozharness: 2017-09-14 00:59:54.732046Z] Running clobber step. 17:59:54 INFO - Running pre-action listener: _resource_record_pre_action 17:59:54 INFO - Running main action method: clobber 17:59:54 INFO - rmtree: /builds/slave/test/build 17:59:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:59:55 INFO - Running post-action listener: _resource_record_post_action 17:59:55 INFO - [mozharness: 2017-09-14 00:59:55.746612Z] Finished clobber step (success) 17:59:55 INFO - [mozharness: 2017-09-14 00:59:55.746709Z] Running read-buildbot-config step. 17:59:55 INFO - Running pre-action listener: _resource_record_pre_action 17:59:55 INFO - Running main action method: read_buildbot_config 17:59:55 INFO - Using buildbot properties: 17:59:55 INFO - { 17:59:55 INFO - "project": "", 17:59:55 INFO - "product": "firefox", 17:59:55 INFO - "who": "ryanvm@gmail.com", 17:59:55 INFO - "installer_path": "public/build/target.tar.bz2", 17:59:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:59:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:59:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 17:59:55 INFO - "stage_platform": "linux64-pgo", 17:59:55 INFO - "basedir": "/builds/slave/test", 17:59:55 INFO - "buildnumber": 14, 17:59:55 INFO - "platform": "ubuntu64_hw", 17:59:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:59:55 INFO - "slavebuilddir": "test", 17:59:55 INFO - "taskId": "ORiu5QgDRou7XvatIfWFew", 17:59:55 INFO - "branch": "mozilla-central", 17:59:55 INFO - "script_repo_revision": "production", 17:59:55 INFO - "revision": "c15e2f280729b6503f9455cd4448ab2852eb5806", 17:59:55 INFO - "slavename": "talos-linux64-ix-008", 17:59:55 INFO - "repo_path": "mozilla-central" 17:59:55 INFO - } 17:59:55 INFO - Finding installer, test and symbols from parent task. 17:59:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ORiu5QgDRou7XvatIfWFew'}, attempt #1 17:59:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ORiu5QgDRou7XvatIfWFew'}, attempt #1 17:59:56 INFO - Task dependencies: POjuiEnsQDKLgDbAo4kKuw 17:59:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw'}, attempt #1 17:59:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2 17:59:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.test_packages.json 17:59:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.crashreporter-symbols.zip 17:59:57 INFO - Running post-action listener: _resource_record_post_action 17:59:57 INFO - [mozharness: 2017-09-14 00:59:57.113519Z] Finished read-buildbot-config step (success) 17:59:57 INFO - [mozharness: 2017-09-14 00:59:57.113738Z] Running download-and-extract step. 17:59:57 INFO - Running pre-action listener: _resource_record_pre_action 17:59:57 INFO - Running main action method: download_and_extract 17:59:57 INFO - mkdir: /builds/slave/test/build/tests 17:59: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')]} 17:59:57 INFO - trying https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.test_packages.json 17:59:57 INFO - Downloading https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:59:57 INFO - Downloaded 989 bytes. 17:59:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:59:57 INFO - Using the following test package requirements: 17:59:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:59:57 INFO - u'common': [u'target.common.tests.zip'], 17:59:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:59:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:59:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:59:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:59:57 INFO - u'mozbase': [u'target.common.tests.zip'], 17:59:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:59:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:59:57 INFO - u'web-platform': [u'target.common.tests.zip', 17:59:57 INFO - u'target.web-platform.tests.tar.gz'], 17:59:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:59:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.common.tests.zip 17:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.common.tests.zip into memory 17:59:58 INFO - Content-Length response header: 55176249 17:59:58 INFO - Bytes received: 55176249 18:00:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.talos.tests.zip 18:00:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:00:09 INFO - Fetch https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.talos.tests.zip into memory 18:00:10 INFO - Content-Length response header: 14500356 18:00:10 INFO - Bytes received: 14500356 18:00: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')]} 18:00:10 INFO - trying https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2 18:00:10 INFO - Downloading https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:00:11 INFO - Downloaded 61998311 bytes. 18:00:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2 18:00:11 INFO - mkdir: /builds/slave/test/properties 18:00:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:11 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:11 INFO - Contents: 18:00:11 INFO - build_url:https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2 18:00:11 INFO - Running post-action listener: _resource_record_post_action 18:00:11 INFO - Running post-action listener: find_tests_for_verification 18:00:11 INFO - Running post-action listener: set_extra_try_arguments 18:00:11 INFO - [mozharness: 2017-09-14 01:00:11.870704Z] Finished download-and-extract step (success) 18:00:11 INFO - [mozharness: 2017-09-14 01:00:11.870929Z] Running populate-webroot step. 18:00:11 INFO - Running pre-action listener: _resource_record_pre_action 18:00:11 INFO - Running main action method: populate_webroot 18:00:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:00:11 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['tresize', 18:00:11 INFO - 'tcanvasmark']}, 18:00:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:00:11 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['dromaeo_css', 18:00:11 INFO - 'kraken']}, 18:00:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:11 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'tests': ['damp', 'tps']}, 18:00:11 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['damp', 'tps']}, 18:00:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:11 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['dromaeo_dom']}, 18:00:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:00:11 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['basic_compositor_video', 18:00:11 INFO - 'glvideo']}, 18:00:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:00:11 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['ts_paint_webext', 18:00:11 INFO - 'tp5o_webext']}, 18:00:11 INFO - 'other-e10s': {'tests': ['a11yr', 18:00:11 INFO - 'ts_paint', 18:00:11 INFO - 'tpaint', 18:00:11 INFO - 'sessionrestore', 18:00:11 INFO - 'sessionrestore_many_windows', 18:00:11 INFO - 'sessionrestore_no_auto_restore', 18:00:11 INFO - 'tabpaint']}, 18:00:11 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['a11yr', 18:00:11 INFO - 'ts_paint', 18:00:11 INFO - 'tpaint', 18:00:11 INFO - 'sessionrestore', 18:00:11 INFO - 'sessionrestore_many_windows', 18:00:11 INFO - 'sessionrestore_no_auto_restore', 18:00:11 INFO - 'tabpaint']}, 18:00:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:00:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:00:11 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['bloom_basic_singleton']}, 18:00:11 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['bloom_basic']}, 18:00:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:00:11 INFO - 'tsvgr_opacity', 18:00:11 INFO - 'tart', 18:00:11 INFO - 'tscrollx', 18:00:11 INFO - 'tsvg_static']}, 18:00:11 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['tsvgx', 18:00:11 INFO - 'tsvgr_opacity', 18:00:11 INFO - 'tart', 18:00:11 INFO - 'tscrollx', 18:00:11 INFO - 'tsvg_static']}, 18:00:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:00:11 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'talos_options': ['--disable-stylo'], 18:00:11 INFO - 'tests': ['tp5o']}, 18:00:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:00:11 INFO - 'talos_options': ['--mitmproxy', 18:00:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:00:11 INFO - '--firstNonBlankPaint'], 18:00:11 INFO - 'tests': ['tp6_google', 18:00:11 INFO - 'tp6_youtube', 18:00:11 INFO - 'tp6_amazon', 18:00:11 INFO - 'tp6_facebook']}, 18:00:11 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:00:11 INFO - 'talos_options': ['--disable-stylo', 18:00:11 INFO - '--mitmproxy', 18:00:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:00:11 INFO - '--firstNonBlankPaint'], 18:00:11 INFO - 'tests': ['tp6_google', 18:00:11 INFO - 'tp6_youtube', 18:00:11 INFO - 'tp6_amazon', 18:00:11 INFO - 'tp6_facebook']}, 18:00:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:00:11 INFO - 'talos_options': ['--stylo-threads=1', 18:00:11 INFO - '--mitmproxy', 18:00:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:00:11 INFO - '--firstNonBlankPaint'], 18:00:11 INFO - 'tests': ['tp6_google', 18:00:11 INFO - 'tp6_youtube', 18:00:11 INFO - 'tp6_amazon', 18:00:11 INFO - 'tp6_facebook']}, 18:00:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'talos_options': ['--xperf_path', 18:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:11 INFO - 'tests': ['tp5n']}, 18:00:11 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 18:00:11 INFO - 'talos_options': ['--disable-stylo', 18:00:11 INFO - '--xperf_path', 18:00:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:11 INFO - 'tests': ['tp5n']}}} 18:00:11 INFO - Running post-action listener: _resource_record_post_action 18:00:11 INFO - [mozharness: 2017-09-14 01:00:11.888865Z] Finished populate-webroot step (success) 18:00:11 INFO - [mozharness: 2017-09-14 01:00:11.889023Z] Running create-virtualenv step. 18:00:11 INFO - Running pre-action listener: _resource_record_pre_action 18:00:11 INFO - Running main action method: create_virtualenv 18:00:11 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:11 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:00:11 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:00:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:00:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:12 INFO - Installing pip...............done. 18:00:12 INFO - Return code: 0 18:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:00:12 INFO - Reading from file tmpfile_stdout 18:00:12 INFO - Output received: 18:00:12 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:00:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:13 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:13 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 18:00:13 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 18:00:13 INFO - Using env: {'DISPLAY': ':0', 18:00:13 INFO - 'HOME': '/home/cltbld', 18:00:13 INFO - 'LANG': 'en_US.UTF-8', 18:00:13 INFO - 'LANGUAGE': 'en_US:en', 18:00:13 INFO - 'LOGNAME': 'cltbld', 18:00:13 INFO - 'MAIL': '/var/mail/cltbld', 18:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:13 INFO - 'MOZ_NO_REMOTE': '1', 18:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:13 INFO - 'NO_EM_RESTART': '1', 18:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:13 INFO - 'PWD': '/builds/slave/test', 18:00:13 INFO - 'SHELL': '/bin/bash', 18:00:13 INFO - 'SHLVL': '1', 18:00:13 INFO - 'TERM': 'linux', 18:00:13 INFO - 'TMOUT': '86400', 18:00:13 INFO - 'USER': 'cltbld', 18:00:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:13 INFO - '_': '/tools/buildbot/bin/python'} 18:00:14 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:00:14 INFO - Downloading/unpacking pip>=1.5 18:00:14 INFO - Running setup.py egg_info for package pip 18:00:14 INFO - warning: no files found matching 'pip/cacert.pem' 18:00:14 INFO - warning: no files found matching '*.html' under directory 'docs' 18:00:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:00:14 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:00:14 INFO - Installing collected packages: pip 18:00:14 INFO - Found existing installation: pip 1.1 18:00:14 INFO - Uninstalling pip: 18:00:14 INFO - Successfully uninstalled pip 18:00:14 INFO - Running setup.py install for pip 18:00:14 INFO - warning: no files found matching 'pip/cacert.pem' 18:00:14 INFO - warning: no files found matching '*.html' under directory 'docs' 18:00:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:00:14 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:00:14 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:00:14 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:00:14 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:00:14 INFO - Successfully installed pip 18:00:14 INFO - Cleaning up... 18:00:14 INFO - Return code: 0 18:00:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:00:14 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')]} 18:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:14 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')]} 18:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:14 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:14 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 18:00:14 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 18:00:14 INFO - Using env: {'DISPLAY': ':0', 18:00:14 INFO - 'HOME': '/home/cltbld', 18:00:14 INFO - 'LANG': 'en_US.UTF-8', 18:00:14 INFO - 'LANGUAGE': 'en_US:en', 18:00:14 INFO - 'LOGNAME': 'cltbld', 18:00:14 INFO - 'MAIL': '/var/mail/cltbld', 18:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:14 INFO - 'MOZ_NO_REMOTE': '1', 18:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:14 INFO - 'NO_EM_RESTART': '1', 18:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:14 INFO - 'PWD': '/builds/slave/test', 18:00:14 INFO - 'SHELL': '/bin/bash', 18:00:14 INFO - 'SHLVL': '1', 18:00:14 INFO - 'TERM': 'linux', 18:00:14 INFO - 'TMOUT': '86400', 18:00:14 INFO - 'USER': 'cltbld', 18:00:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:14 INFO - '_': '/tools/buildbot/bin/python'} 18:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:14 INFO - Downloading/unpacking psutil>=3.1.1 18:00:14 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 18:00:14 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 18:00:14 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 18:00:14 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 18:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:15 INFO - Installing collected packages: psutil 18:00:15 INFO - Running setup.py install for psutil 18:00:15 INFO - building 'psutil._psutil_linux' extension 18:00:15 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 18:00:15 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 18:00:15 INFO - building 'psutil._psutil_posix' extension 18:00:15 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 18:00:16 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 18:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:16 INFO - Successfully installed psutil 18:00:16 INFO - Cleaning up... 18:00:16 INFO - Return code: 0 18:00:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:00:16 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')]} 18:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:16 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')]} 18:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:16 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:16 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 18:00:16 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 18:00:16 INFO - Using env: {'DISPLAY': ':0', 18:00:16 INFO - 'HOME': '/home/cltbld', 18:00:16 INFO - 'LANG': 'en_US.UTF-8', 18:00:16 INFO - 'LANGUAGE': 'en_US:en', 18:00:16 INFO - 'LOGNAME': 'cltbld', 18:00:16 INFO - 'MAIL': '/var/mail/cltbld', 18:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:16 INFO - 'MOZ_NO_REMOTE': '1', 18:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:16 INFO - 'NO_EM_RESTART': '1', 18:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:16 INFO - 'PWD': '/builds/slave/test', 18:00:16 INFO - 'SHELL': '/bin/bash', 18:00:16 INFO - 'SHLVL': '1', 18:00:16 INFO - 'TERM': 'linux', 18:00:16 INFO - 'TMOUT': '86400', 18:00:16 INFO - 'USER': 'cltbld', 18:00:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:16 INFO - '_': '/tools/buildbot/bin/python'} 18:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:00:17 INFO - Installing collected packages: mozsystemmonitor 18:00:17 INFO - Running setup.py install for mozsystemmonitor 18:00:17 INFO - Successfully installed mozsystemmonitor 18:00:17 INFO - Cleaning up... 18:00:18 INFO - Return code: 0 18:00:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:18 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:18 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 18:00:18 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 18:00:18 INFO - Using env: {'DISPLAY': ':0', 18:00:18 INFO - 'HOME': '/home/cltbld', 18:00:18 INFO - 'LANG': 'en_US.UTF-8', 18:00:18 INFO - 'LANGUAGE': 'en_US:en', 18:00:18 INFO - 'LOGNAME': 'cltbld', 18:00:18 INFO - 'MAIL': '/var/mail/cltbld', 18:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:18 INFO - 'MOZ_NO_REMOTE': '1', 18:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:18 INFO - 'NO_EM_RESTART': '1', 18:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:18 INFO - 'PWD': '/builds/slave/test', 18:00:18 INFO - 'SHELL': '/bin/bash', 18:00:18 INFO - 'SHLVL': '1', 18:00:18 INFO - 'TERM': 'linux', 18:00:18 INFO - 'TMOUT': '86400', 18:00:18 INFO - 'USER': 'cltbld', 18:00:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:18 INFO - '_': '/tools/buildbot/bin/python'} 18:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:18 INFO - Downloading/unpacking jsonschema==2.5.1 18:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:00:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:00:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:00:20 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 18:00:20 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 18:00:20 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 18:00:20 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 18:00:20 INFO - Downloading functools32-3.2.3-2.tar.gz 18:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:00:20 INFO - warning: no files found matching '*.txt' 18:00:20 INFO - no previously-included directories found matching 'build' 18:00:20 INFO - no previously-included directories found matching 'dist' 18:00:20 INFO - no previously-included directories found matching '.git*' 18:00:20 INFO - Installing collected packages: jsonschema, functools32 18:00:20 INFO - Running setup.py install for functools32 18:00:20 INFO - warning: no files found matching '*.txt' 18:00:20 INFO - no previously-included directories found matching 'build' 18:00:20 INFO - no previously-included directories found matching 'dist' 18:00:20 INFO - no previously-included directories found matching '.git*' 18:00:20 INFO - Successfully installed jsonschema functools32 18:00:20 INFO - Cleaning up... 18:00:20 INFO - Return code: 0 18:00:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:00:20 INFO - Using env: {'DISPLAY': ':0', 18:00:20 INFO - 'HOME': '/home/cltbld', 18:00:20 INFO - 'LANG': 'en_US.UTF-8', 18:00:20 INFO - 'LANGUAGE': 'en_US:en', 18:00:20 INFO - 'LOGNAME': 'cltbld', 18:00:20 INFO - 'MAIL': '/var/mail/cltbld', 18:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:20 INFO - 'MOZ_NO_REMOTE': '1', 18:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:20 INFO - 'NO_EM_RESTART': '1', 18:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:20 INFO - 'PWD': '/builds/slave/test', 18:00:20 INFO - 'SHELL': '/bin/bash', 18:00:20 INFO - 'SHLVL': '1', 18:00:20 INFO - 'TERM': 'linux', 18:00:20 INFO - 'TMOUT': '86400', 18:00:20 INFO - 'USER': 'cltbld', 18:00:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:20 INFO - '_': '/tools/buildbot/bin/python'} 18:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:00:20 INFO - Cleaning up... 18:00:20 INFO - Return code: 0 18:00:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:00:20 INFO - Using env: {'DISPLAY': ':0', 18:00:20 INFO - 'HOME': '/home/cltbld', 18:00:20 INFO - 'LANG': 'en_US.UTF-8', 18:00:20 INFO - 'LANGUAGE': 'en_US:en', 18:00:20 INFO - 'LOGNAME': 'cltbld', 18:00:20 INFO - 'MAIL': '/var/mail/cltbld', 18:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:20 INFO - 'MOZ_NO_REMOTE': '1', 18:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:20 INFO - 'NO_EM_RESTART': '1', 18:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:20 INFO - 'PWD': '/builds/slave/test', 18:00:20 INFO - 'SHELL': '/bin/bash', 18:00:20 INFO - 'SHLVL': '1', 18:00:20 INFO - 'TERM': 'linux', 18:00:20 INFO - 'TMOUT': '86400', 18:00:20 INFO - 'USER': 'cltbld', 18:00:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:20 INFO - '_': '/tools/buildbot/bin/python'} 18:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:21 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:21 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 18:00:21 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 18:00:21 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 18:00:21 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 18:00:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:00:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:00:22 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 18:00:22 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 18:00:22 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 18:00:22 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 18:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:00:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:00:22 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 18:00:22 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 18:00:22 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 18:00:22 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 18:00:22 INFO - Downloading docopt-0.6.1.tar.gz 18:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:00:22 INFO - Installing collected packages: blobuploader, requests, docopt 18:00:22 INFO - Running setup.py install for blobuploader 18:00:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:00:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:00:22 INFO - Running setup.py install for requests 18:00:23 INFO - Running setup.py install for docopt 18:00:23 INFO - Successfully installed blobuploader requests docopt 18:00:23 INFO - Cleaning up... 18:00:23 INFO - Return code: 0 18:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:23 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')]} 18:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:23 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')]} 18:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:23 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:23 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 18:00:23 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 18:00:23 INFO - Using env: {'DISPLAY': ':0', 18:00:23 INFO - 'HOME': '/home/cltbld', 18:00:23 INFO - 'LANG': 'en_US.UTF-8', 18:00:23 INFO - 'LANGUAGE': 'en_US:en', 18:00:23 INFO - 'LOGNAME': 'cltbld', 18:00:23 INFO - 'MAIL': '/var/mail/cltbld', 18:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:23 INFO - 'MOZ_NO_REMOTE': '1', 18:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:23 INFO - 'NO_EM_RESTART': '1', 18:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:23 INFO - 'PWD': '/builds/slave/test', 18:00:23 INFO - 'SHELL': '/bin/bash', 18:00:23 INFO - 'SHLVL': '1', 18:00:23 INFO - 'TERM': 'linux', 18:00:23 INFO - 'TMOUT': '86400', 18:00:23 INFO - 'USER': 'cltbld', 18:00:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:23 INFO - '_': '/tools/buildbot/bin/python'} 18:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:23 INFO - Running setup.py (path:/tmp/pip-q5wWOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:23 INFO - Running setup.py (path:/tmp/pip-Jo4hPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:23 INFO - Running setup.py (path:/tmp/pip-RXPJ4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:23 INFO - Running setup.py (path:/tmp/pip-0KwPT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:23 INFO - Running setup.py (path:/tmp/pip-npoKP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:23 INFO - Running setup.py (path:/tmp/pip-RYSi2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:24 INFO - Running setup.py (path:/tmp/pip-qrhkBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:24 INFO - Running setup.py (path:/tmp/pip-igAdcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:24 INFO - Running setup.py (path:/tmp/pip-khS9O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:24 INFO - Running setup.py (path:/tmp/pip-EBqkZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:24 INFO - Running setup.py (path:/tmp/pip-u1uM0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:24 INFO - Running setup.py (path:/tmp/pip-j__4iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:24 INFO - Running setup.py (path:/tmp/pip-kOIfJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:24 INFO - Running setup.py (path:/tmp/pip-XRSQoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:24 INFO - Running setup.py (path:/tmp/pip-khWZg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:24 INFO - Running setup.py (path:/tmp/pip-NEpqjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:24 INFO - Running setup.py (path:/tmp/pip-bEzwGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:00:24 INFO - Running setup.py install for manifestparser 18:00:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:00:24 INFO - Running setup.py install for mozcrash 18:00:24 INFO - Running setup.py install for mozdebug 18:00:25 INFO - Running setup.py install for mozdevice 18:00:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozfile 18:00:25 INFO - Running setup.py install for mozhttpd 18:00:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozinfo 18:00:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozInstall 18:00:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozleak 18:00:25 INFO - Running setup.py install for mozlog 18:00:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for moznetwork 18:00:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:00:25 INFO - Running setup.py install for mozprocess 18:00:26 INFO - Running setup.py install for mozprofile 18:00:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Running setup.py install for mozrunner 18:00:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Running setup.py install for mozscreenshot 18:00:26 INFO - Running setup.py install for moztest 18:00:26 INFO - Running setup.py install for mozversion 18:00:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:00:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:00:26 INFO - Cleaning up... 18:00:26 INFO - Return code: 0 18:00:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:26 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')]} 18:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:26 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')]} 18:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:26 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:26 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 18:00:26 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 18:00:26 INFO - Using env: {'DISPLAY': ':0', 18:00:26 INFO - 'HOME': '/home/cltbld', 18:00:26 INFO - 'LANG': 'en_US.UTF-8', 18:00:26 INFO - 'LANGUAGE': 'en_US:en', 18:00:26 INFO - 'LOGNAME': 'cltbld', 18:00:26 INFO - 'MAIL': '/var/mail/cltbld', 18:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:26 INFO - 'MOZ_NO_REMOTE': '1', 18:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:26 INFO - 'NO_EM_RESTART': '1', 18:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:26 INFO - 'PWD': '/builds/slave/test', 18:00:26 INFO - 'SHELL': '/bin/bash', 18:00:26 INFO - 'SHLVL': '1', 18:00:26 INFO - 'TERM': 'linux', 18:00:26 INFO - 'TMOUT': '86400', 18:00:26 INFO - 'USER': 'cltbld', 18:00:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:26 INFO - '_': '/tools/buildbot/bin/python'} 18:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:00:26 INFO - Running setup.py (path:/tmp/pip-OmE2Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:00:26 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)) 18:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:00:26 INFO - Running setup.py (path:/tmp/pip-WZ0SHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:00:26 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)) 18:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:00:26 INFO - Running setup.py (path:/tmp/pip-AD6L0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:00:26 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)) 18:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:00:27 INFO - Running setup.py (path:/tmp/pip-pPTEAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:00:27 INFO - Running setup.py (path:/tmp/pip-IWxGbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:00:27 INFO - Running setup.py (path:/tmp/pip-9OX56d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:00:27 INFO - Running setup.py (path:/tmp/pip-LXIgDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:00:27 INFO - Running setup.py (path:/tmp/pip-xIJ29o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:00:27 INFO - Running setup.py (path:/tmp/pip-_vPRcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:00:27 INFO - Running setup.py (path:/tmp/pip-C4c0IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:00:27 INFO - Running setup.py (path:/tmp/pip-09EG9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:00:27 INFO - Running setup.py (path:/tmp/pip-GHi3OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:00:27 INFO - Running setup.py (path:/tmp/pip-VR0wLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:00:27 INFO - Running setup.py (path:/tmp/pip-0bkp86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:27 INFO - Running setup.py (path:/tmp/pip-kn39AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:00:27 INFO - Running setup.py (path:/tmp/pip-CIotMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:00:27 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)) 18:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:00:27 INFO - Running setup.py (path:/tmp/pip-UyGk7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:00:27 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)) 18:00:27 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)) 18:00:27 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)) 18:00:27 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)) 18:00:27 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)) 18:00:27 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)) 18:00:27 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)) 18:00:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:00:28 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 18:00:28 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 18:00:28 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 18:00:28 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 18:00:29 INFO - Downloading blessings-1.6.tar.gz 18:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:00:29 INFO - Installing collected packages: blessings 18:00:29 INFO - Running setup.py install for blessings 18:00:29 INFO - Successfully installed blessings 18:00:29 INFO - Cleaning up... 18:00:29 INFO - Return code: 0 18:00:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:29 INFO - Reading from file tmpfile_stdout 18:00:29 INFO - Current package versions: 18:00:29 INFO - argparse == 1.2.1 18:00:29 INFO - blessings == 1.6 18:00:29 INFO - blobuploader == 1.2.4 18:00:29 INFO - docopt == 0.6.1 18:00:29 INFO - functools32 == 3.2.3-2 18:00:29 INFO - jsonschema == 2.5.1 18:00:29 INFO - manifestparser == 1.1 18:00:29 INFO - mozInstall == 1.13 18:00:29 INFO - mozcrash == 1.0 18:00:29 INFO - mozdebug == 0.1 18:00:29 INFO - mozdevice == 0.51 18:00:29 INFO - mozfile == 1.2 18:00:29 INFO - mozhttpd == 0.7 18:00:29 INFO - mozinfo == 0.10 18:00:29 INFO - mozleak == 0.1 18:00:29 INFO - mozlog == 3.5 18:00:29 INFO - moznetwork == 0.27 18:00:29 INFO - mozprocess == 0.25 18:00:29 INFO - mozprofile == 0.28 18:00:29 INFO - mozrunner == 6.13 18:00:29 INFO - mozscreenshot == 0.1 18:00:29 INFO - mozsystemmonitor == 0.3 18:00:29 INFO - moztest == 0.8 18:00:29 INFO - mozversion == 1.4 18:00:29 INFO - psutil == 3.1.1 18:00:29 INFO - requests == 1.2.3 18:00:29 INFO - wsgiref == 0.1.2 18:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:29 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:29 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 18:00:29 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 18:00:29 INFO - Using env: {'DISPLAY': ':0', 18:00:29 INFO - 'HOME': '/home/cltbld', 18:00:29 INFO - 'LANG': 'en_US.UTF-8', 18:00:29 INFO - 'LANGUAGE': 'en_US:en', 18:00:29 INFO - 'LOGNAME': 'cltbld', 18:00:29 INFO - 'MAIL': '/var/mail/cltbld', 18:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:29 INFO - 'MOZ_NO_REMOTE': '1', 18:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:29 INFO - 'NO_EM_RESTART': '1', 18:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:29 INFO - 'PWD': '/builds/slave/test', 18:00:29 INFO - 'SHELL': '/bin/bash', 18:00:29 INFO - 'SHLVL': '1', 18:00:29 INFO - 'TERM': 'linux', 18:00:29 INFO - 'TMOUT': '86400', 18:00:29 INFO - 'USER': 'cltbld', 18:00:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:29 INFO - '_': '/tools/buildbot/bin/python'} 18:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 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)) 18:00:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:00:29 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 18:00:29 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 18:00:29 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 18:00:29 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 18:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:00:30 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)) 18:00:30 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)) 18:00:30 INFO - Installing collected packages: simplejson 18:00:30 INFO - Running setup.py install for simplejson 18:00:31 INFO - building 'simplejson._speedups' extension 18:00:31 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 18:00:31 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 18:00:31 INFO - Successfully installed simplejson 18:00:31 INFO - Cleaning up... 18:00:31 INFO - Return code: 0 18:00:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:00:31 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')]} 18:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:31 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')]} 18:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:32 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 0x24c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282fa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, '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': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', '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 18:00:32 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 18:00:32 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 18:00:32 INFO - Using env: {'DISPLAY': ':0', 18:00:32 INFO - 'HOME': '/home/cltbld', 18:00:32 INFO - 'LANG': 'en_US.UTF-8', 18:00:32 INFO - 'LANGUAGE': 'en_US:en', 18:00:32 INFO - 'LOGNAME': 'cltbld', 18:00:32 INFO - 'MAIL': '/var/mail/cltbld', 18:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:32 INFO - 'MOZ_NO_REMOTE': '1', 18:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:32 INFO - 'NO_EM_RESTART': '1', 18:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:32 INFO - 'PWD': '/builds/slave/test', 18:00:32 INFO - 'SHELL': '/bin/bash', 18:00:32 INFO - 'SHLVL': '1', 18:00:32 INFO - 'TERM': 'linux', 18:00:32 INFO - 'TMOUT': '86400', 18:00:32 INFO - 'USER': 'cltbld', 18:00:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:32 INFO - '_': '/tools/buildbot/bin/python'} 18:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:00:32 INFO - Cleaning up... 18:00:32 INFO - Return code: 0 18:00:32 INFO - Running post-action listener: _resource_record_post_action 18:00:32 INFO - Running post-action listener: _start_resource_monitoring 18:00:32 INFO - Starting resource monitoring. 18:00:32 INFO - [mozharness: 2017-09-14 01:00:32.259618Z] Finished create-virtualenv step (success) 18:00:32 INFO - [mozharness: 2017-09-14 01:00:32.260135Z] Running install step. 18:00:32 INFO - Running pre-action listener: _resource_record_pre_action 18:00:32 INFO - Running main action method: install 18:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:00:32 INFO - Reading from file tmpfile_stdout 18:00:32 INFO - Detecting whether we're running mozinstall >=1.0... 18:00:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:00:32 INFO - Reading from file tmpfile_stdout 18:00:32 INFO - Output received: 18:00:32 INFO - Usage: mozinstall [options] installer 18:00:32 INFO - Options: 18:00:32 INFO - -h, --help show this help message and exit 18:00:32 INFO - -d DEST, --destination=DEST 18:00:32 INFO - Directory to install application into. [default: 18:00:32 INFO - "/builds/slave/test"] 18:00:32 INFO - --app=APP Application being installed. [default: firefox] 18:00:32 INFO - mkdir: /builds/slave/test/build/application 18:00:32 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'] 18:00:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:00:50 INFO - Reading from file tmpfile_stdout 18:00:50 INFO - Output received: 18:00:50 INFO - /builds/slave/test/build/application/firefox/firefox 18:00:50 INFO - Running post-action listener: _resource_record_post_action 18:00:50 INFO - [mozharness: 2017-09-14 01:00:50.286732Z] Finished install step (success) 18:00:50 INFO - [mozharness: 2017-09-14 01:00:50.287067Z] Running setup-mitmproxy step. 18:00:50 INFO - Running pre-action listener: _resource_record_pre_action 18:00:50 INFO - Running main action method: setup_mitmproxy 18:00:50 INFO - Skipping: mitmproxy is not required 18:00:50 INFO - Running post-action listener: _resource_record_post_action 18:00:50 INFO - [mozharness: 2017-09-14 01:00:50.288205Z] Finished setup-mitmproxy step (success) 18:00:50 INFO - [mozharness: 2017-09-14 01:00:50.288427Z] Running run-tests step. 18:00:50 INFO - Running pre-action listener: _resource_record_pre_action 18:00:50 INFO - Running pre-action listener: _set_gcov_prefix 18:00:50 INFO - Running main action method: run_tests 18:00:50 WARNING - Try message not found. 18:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:00:50 INFO - Python 2.7.3 18:00:50 INFO - Return code: 0 18:00:50 INFO - grabbing minidump binary from tooltool 18:00: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')]} 18:00:50 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 0x2833090>, '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 0x2833d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282df90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:00:50 INFO - Return code: 0 18:00:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:00:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:00:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:00:50 INFO - ENV: RUST_BACKTRACE is now full 18:00:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:00:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 18:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 18:00:50 INFO - Using env: {'DISPLAY': ':0', 18:00:50 INFO - 'HOME': '/home/cltbld', 18:00:50 INFO - 'LANG': 'en_US.UTF-8', 18:00:50 INFO - 'LANGUAGE': 'en_US:en', 18:00:50 INFO - 'LOGNAME': 'cltbld', 18:00:50 INFO - 'MAIL': '/var/mail/cltbld', 18:00:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:00:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:50 INFO - 'MOZ_NO_REMOTE': '1', 18:00:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:50 INFO - 'NO_EM_RESTART': '1', 18:00:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:50 INFO - 'PWD': '/builds/slave/test', 18:00:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:00:50 INFO - 'RUST_BACKTRACE': 'full', 18:00:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:00:50 INFO - 'SHELL': '/bin/bash', 18:00:50 INFO - 'SHLVL': '1', 18:00:50 INFO - 'TERM': 'linux', 18:00:50 INFO - 'TMOUT': '86400', 18:00:50 INFO - 'USER': 'cltbld', 18:00:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:50 INFO - '_': '/tools/buildbot/bin/python'} 18:00:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 18:00:50 INFO - mozversion application_buildid: 20170913233914 18:00:50 INFO - mozversion application_changeset: c15e2f280729b6503f9455cd4448ab2852eb5806 18:00:50 INFO - mozversion application_display_name: Nightly 18:00:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:00:50 INFO - mozversion application_name: Firefox 18:00:50 INFO - mozversion application_remotingname: firefox 18:00:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:00:50 INFO - mozversion application_vendor: Mozilla 18:00:50 INFO - mozversion application_version: 57.0a1 18:00:50 INFO - mozversion platform_buildid: 20170913233914 18:00:50 INFO - mozversion platform_changeset: c15e2f280729b6503f9455cd4448ab2852eb5806 18:00:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:00:50 INFO - mozversion platform_version: 57.0a1 18:00:50 INFO - using testdate: 1505350850 18:00:50 INFO - actual date: 1505350850 18:00:50 INFO - starting webserver on 'localhost:44848' 18:00:50 INFO - SUITE-START | Running 2 tests 18:00:50 INFO - TEST-START | dromaeo_css 18:00:50 INFO - Initialising browser for dromaeo_css test... 18:00:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44848/getInfo.html -profile /tmp/tmpAkVWgv/profile 18:00:50 INFO - TEST-INFO | started process 15125 (/builds/slave/test/build/application/firefox/firefox http://localhost:44848/getInfo.html) 18:00:56 INFO - TEST-INFO | 15125: exit 0 18:00:56 INFO - Browser initialized. 18:00:56 INFO - Running cycle 1/1 for dromaeo_css test... 18:00:56 INFO - Using env: {'DISPLAY': ':0', 18:00:56 INFO - 'HOME': '/home/cltbld', 18:00:56 INFO - 'JSGC_DISABLE_POISONING': '1', 18:00:56 INFO - 'LANG': 'en_US.UTF-8', 18:00:56 INFO - 'LANGUAGE': 'en_US:en', 18:00:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MAIL': '/var/mail/cltbld', 18:00:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:00:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:00:56 INFO - 'MOZ_CRASHREPORTER': '1', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:00:56 INFO - 'RUST_BACKTRACE': 'full', 18:00:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SHLVL': '1', 18:00:56 INFO - 'STYLO_FORCE_DISABLED': '1', 18:00:56 INFO - 'TERM': 'linux', 18:00:56 INFO - 'TMOUT': '86400', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - '_': '/tools/buildbot/bin/python'} 18:00:56 INFO - TEST-INFO | started process 15362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAkVWgv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:00:57 INFO - PID 15362 | 18:00:57 INFO - PID 15362 | (/builds/slave/test/build/application/firefox/firefox:15411): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:00:57 INFO - PID 15362 | 18:01:07 INFO - PID 15362 | RSS: Main: 165240832 18:01:07 INFO - PID 15362 | 18:04:05 INFO - PID 15362 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44848/tests/dromaeo/cssquery-ext.html) 18:04:06 INFO - PID 15362 | RSS: Main: 169402368 18:04:06 INFO - PID 15362 | 18:07:08 INFO - PID 15362 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-ext.html (next: http://localhost:44848/tests/dromaeo/cssquery-jquery.html) 18:07:08 INFO - PID 15362 | RSS: Main: 165318656 18:07:08 INFO - PID 15362 | 18:10:10 INFO - PID 15362 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44848/tests/dromaeo/cssquery-mootools.html) 18:10:10 INFO - PID 15362 | RSS: Main: 167895040 18:10:10 INFO - PID 15362 | 18:13:12 INFO - PID 15362 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44848/tests/dromaeo/cssquery-prototype.html) 18:13:12 INFO - PID 15362 | RSS: Main: 166010880 18:13:12 INFO - PID 15362 | 18:16:15 INFO - PID 15362 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44848/tests/dromaeo/cssquery-yui.html) 18:16:16 INFO - PID 15362 | RSS: Main: 167763968 18:16:16 INFO - PID 15362 | 18:19:17 INFO - PID 15362 | Cycle 1(1): loaded http://localhost:44848/tests/dromaeo/cssquery-yui.html (next: http://localhost:44848/tests/dromaeo/cssquery-dojo.html) 18:19:17 INFO - PID 15362 | RSS: Main: 170999808 18:19:17 INFO - PID 15362 | 18:19:17 INFO - PID 15362 | __start_tp_report 18:19:17 INFO - PID 15362 | _x_x_mozilla_page_load 18:19:17 INFO - PID 15362 | _x_x_mozilla_page_load_details 18:19:17 INFO - PID 15362 | |i|pagename|runs| 18:19:18 INFO - PID 15362 | |0;dojo.html;3801.3537698591244;3841.23175364927;3881.26256011358;3884.4755957945667;3899.805009749512;6178.598391104586;6257.71840267188;6281.685915704214;6304.71628776705;6341.873162536746;6323.114763933041;6326.145970294009;6357.3642635736405;6362.745490180388;6364.554481186319;5584.078627026536;5614.2701448811595;5640.943590564103;5647.463490968352;5726.570507211955;5711.857203569903;5714.799982000631;5748.223989761392;5753.050746626802;5781.103928891029;5677;5688.4311568843195;5718.942810571883;5730.111832665943;5769.798057068004;5471.398146203915;5612.438756124355;5619.044762390404;5705.315362156526;5722.4277572242445;5586.776528938837;5603.131514615241;5664.122061080498;5664.461876121762;5679.772809087632;6146.66193359365;6188.350223226586;6224.813255602339;6274.121622972787;6347.333529979378;6801.863962720768;6822.863542729167;6833.077534532824;6846.075779769717;6857.040014397989;6797.796066118024;6803.523753337268;6815.931840681579;6888.827779305508;6893.724251030003;6269.310375858652;6365.077063825719;6386.393292637145;6394.6482943438095;6425.1968503937005;6946.374826265559;6950.895736563955;7004.264552221944;7038;7043.36609705129;6575.868482630416;6745.5952642841585;6749.0888730020815;6756.223034351015;6761.053452516651;6765.627890465973;6777.2545020047755;6788.185417749902;6867.450603951672;6893.724251030003;6664;6699.631520266432;6728.966355168192;6749.358810912955;6808.829779255559;6701.966490167615;6742.5280230383405;6766.5263431559315;6783.932160678429;6828.2147553031045;4879.463259041502;4996.850094497171;5016.724080175625;5020.799168033238;5023.79904803811;4413.823447062082;4505.617022553054;4508.391367165391;4510.075434535912;4531.977340113278;6248.718807653576;6309;6336.873262534816;6348.746050157942;6363.522735794834;6751.0886030386255;6756.087928129639;6830.897536536956;6834.316568343225;6845.041694162821;6266.310705822356;6294.464970477561;6346.682665866781;6361.745530178833;6371.458426033746;5416.83749487516;5430.755615997211;5458.61789674719;5484.698341591171;5519.448055194448;6943.548669336477;7007.194172670106;7091.2554181810165;7113.466490013269;7125.608091554911;6700.899486507608;6714.597124172566;6780.762673306411;6792.660366981631;6805.455563555002;7018.298170182941;7042.964785176041;7114.359707626339;7117.039199707973;7123.394511466583;6670.899936500859;6693.899591506229;6734.326567343226;6749;6753.696083676345;6686.13080299558;6842.315768423118;6850.21222559412;6850.965745171242;6854.794356169323;6452.161219041494;6476.838079048061;6540.444062254762;6558.213014438298;6585.934140658532;6442.806715798533;6476.838079048061;6543.345665433419;6563;6588.637624930483;6441;6516.51126165549;6538.1827271591055;6555.049517819984;6586.769463068769;6463.870722585428;6584.440322572635;6594.604323740591;6665.233498147775;6669.2997235289595;6299.401556852092;6389.8722025560155;6400.743970241325;6424.10062591247;6448.742050318122 18:19:18 INFO - PID 15362 | |1;ext.html;966.1449617088876;985.9605615775374;987.289151810696;991.8660980767598;995.9352642078264;41992;46784.53215467844;46904.29643555349;47008.29487557685;47019.764901175535;42755.572444275545;43075;43096;43107.56892431075;43145.78427107868;7605.2014538473495;8248.83502329953;8436.240738333549;8465.153484651548;8469.74590762275;8246.958765206165;8344.040435349953;8370.288525475342;8372.28835548979;8374.581270936429;8328.708495202638;8391.70629027984;8392.874106888401;8394.454360466581;8396.790080248013;8340.29107525858;8375.20435558621;8385.119562445978;8385.287250583708;8389.035260944978;8234.258916697527;8234.629441675139;8248;8283.751487455385;8283.875741863876;40955.385669214986;41012;41018.589814101775;41140.1771964562;41162.79418602888;3742.1954279829697;3746.737728359016;3771.924561508782;3773.2830762155377;3773.8867833965023;33859.15352116192;33906.49140262898;33917.66082339195;33935.15162120942;34076;5349.197620356938;5472.288602481652;5528.143137813645;5552.278203833516;5589.077802162638;213746;214307;214938;215549;215816;46840.5315946843;48095;52472;52529.737351313;53936.46063539393;58805.70597146987;58974;59039;59053.70473147607;59085;14807.0375425597;14882.627934301512;14887.627809304853;14891.627709307353;14896.62758431048;11653.834616538279;11654.941725291319;11655;11666.88333116658;11667;15731.921340393224;15762.211889405713;15823;15843.207839607974;15894.602634933988;6122.245089615747;6178.567500274938;6210.72051757672;6256.155419018374;6313.652749098844;1084.5661735305941;1100.1638754546443;1113.6325012745774;1119.3619636807105;1121.5850135449937;25709;26172.607410888853;26186.08348707786;26240.60639090415;26422.86788566045;1184.7452797648375;1189.5776999165346;1193.731410432663;1206.631977246948;1208.9516419343129;13686.589402317946;13726.65683357924;13747.450101996008;13799.586012419644;13907.23510206928;275363;276439;277179;277792;278052;59541.40458595445;59926;59977;60019.39980600226;60169.398306017254;1507.5025241670442;1523.5657837516476;1525.6185953511622;1547.7214101461846;1566.0134115507158;25296.39927915669;25407.6188857171;25691.35771605725;25782.742172578033;25830;42713.145737084466;42892.14215715731;43023.1395372097;43053;43148;252133;252500;253039;253278;253663;37807.24385512329;40796.79601602092;41349.586504134575;41628;41778.37332439955;50597.494025060754;52538.73730631475;52803.73598131985;52822.73588632032;52855.73572132115;37292.254154916205;37831;37846.62153378431;37993.62006379901;38109.23781524299;37433.43849842309;37536.43695344627;37580.81209594044;37830.43254351242;37854.43218351782;43604;43937.12125757531;44324.11351773011;44755;44797;35985.28029439449;36214;36295.45556816597;36310.455343170404;36593.45109823408;27012.594811077455;27017.3245668852;27399.863000685666;27475.86262068677;27682.723172768016 18:19:18 INFO - PID 15362 | |2;jquery.html;567.239898535962;579.1660009586193;581.5603543136544;593.1281016905149;598.389642564584;22920.197793077245;23693.644595331083;23716.407089822762;23724.64413033806;23734.525309493798;23718.88140559299;25033.62449563258;25364.492710145787;25414;25470.617940730903;6503.414692677658;6555.213374395055;6597.637129957874;6599.076129341896;6637.601743895358;6219.9689001554925;6411.070394792752;6424.743010279583;6428.8071357859335;6429.8392540186405;6407.8398040048905;6422.614643121405;6428.742850285983;6443.871122577546;6464.450521705638;6470.644114573673;6470.802901463221;6473.417392434656;6474.514411419115;6474.579152355105;5994.37059108796;6008.279006519202;6010.128531362971;6018.217631707894;6045;28164.718352816413;29133.56299655507;29272;29597.852010739807;29602.111936641933;2222.0556263588073;2237.205791943869;2244.5623103494827;2246.5619204255177;2247.404437823978;19777.9011104945;20439;20440.591188176302;20463.795362046487;20489.795102049087;2523.621456781479;2550.0692247329775;2600.2069368842494;2603.3621762668267;2607.361196506868;136196;142312.28843855715;148494;154387;157755.99999999886;15536.611584710246;16069.276882540315;16155.676886462204;16252.349906003863;16351;24923.376915576893;24954.251372458857;24963.87518062398;24967.375815604755;24987.375315616893;9445.952770236105;9527.38072025316;9589.280803939733;9663.323567350219;9720.562574684156;8316.334693224528;8346.874796878052;8444.408891377545;8460.153984601613;8517.44636598619;9804.264680149017;9913.950430247802;9981.700548983543;10019.448930308903;10080.925317778001;2876.6548014238006;2892.4070565534016;2969.302213979713;3025.3949210157616;3068.2942923127357;1045.2630895218851;1050.4432650695144;1053.5680371047833;1060.6977011551671;1061.4692653673164;20135.697964530544;20352.18591256333;20485.48786280325;20855.47861303449;21175.36473905785;1069.315637991686;1092.4865313302735;1110.7556337605713;1114.3815182573749;1117.7987962166887;11227.045701115496;11338.773224535464;11411.885881141248;11421.714457138472;11509.136814738928;561036;588948;598583;620969;622950;129289.35355323351;129743.35128324486;132217.33891330482;133026.33486832504;133069;1101.6970333158285;1215.5016443258398;1227.4169769359482;1248.731522722619;1273.7006803401193;21558.568828623655;21949.231776887733;21952.341429757133;22209.666854996864;22294.554108918055;63866.3613363879;64030;67314.66342668256;67857.3214267851;69509;79426;80945.59527202326;81503.59248203959;82383.5880820592;82985;20215.39353819388;20847;20893.686594700786;20939.790602094392;20940.162393504088;23743.81280935981;23827.285181444586;23973.400664983514;24074.037038518964;24130.758692413554;17959;17969.281228750704;18083.728744068587;18112.275508979492;18860.905695471436;16718.247678854237;17309.56726081858;17389.739153912447;17776.288948441917;17891.19489622996;18701.812981870553;19277.22891084341;19366.225350985802;19596.314129005415;19702.1134048971;20533.589328213053;20548.589028219652;20571;20642;20715.27496537614;18480.16839242264;18507.629847403245;18828.152733127317;18911.054447277857;18929.33747318837 18:19:18 INFO - PID 15362 | |3;mootools.html;1432.3769160415218;1492.723846088473;1496.0126316631026;1500.707362064397;1503.4512402972919;16763.83236167638;17439;17456.825431745678;17464.126793660314;17468.388606398777;16974.236159372827;17108.31566737332;17114.914425427887;17128.400505982292;17134;2889.8410587417684;2908.8400137992403;2958.5118455454826;2959.1270575180265;2960.48191566475;2723.2102690219813;2732.6857411397746;2733.1390611957268;2733.221032005879;2737.712540183282;2805.775537956969;2851.158908122109;2855.8286502809897;2859.1994241612383;2862.0984389917107;2658.3885706287565;2670.971675904771;2682.637843891079;2683.8121331506804;2685.194441667492;2645.470905818844;2674.2378422149595;2674.4651069785928;2675.1840688589973;2676.076753520052;16535.421260255953;16829.158542072848;16840.157992100347;16858.49424517254;16863;8463.915360846375;8698.21716045559;8704.695335663222;8725.127487251288;8727.432716873383;5327.200919862013;5485.890282194334;5643.068893632546;5725.742341594597;5824.475797178232;1990.9502262443555;1996.7304413904228;2012.1448384436555;2066.3284432559326;2074.543600407923;27560.310992225153;28662.570061449096;29982;30956.69043309583;31024.844875775703;7640.73257435987;7654.158042615308;7846.136924938252;8044.1955804419085;8082.110967793538;23650.526989460457;23661.7633823663;23662.7633723664;23674.053037878635;23696.40758981005;8952.8657070144;8954.059823718546;8955.059718729439;8956.238719708768;8958.731238062868;7546.094468663686;7773.455858089879;7777.922220777833;7789.065312162576;7790.5325680459355;6226;6268.592541484789;6367.90448143269;6473.28793832678;6516.511261655395;1813.1478205243513;1821.2805941652973;1822.5261432027503;1833.2208811255164;1838.981610183881;985.8225519406576;986.6497393425374;993.5082134343546;996.6013594562233;1017.6082208349839;9625.133737963617;9720.173785228335;9813.362131461432;9895.356801807859;10051;748.8839229919371;770.6146926536732;777.766669998998;779.3219898688178;781.2656103262915;4818.445878723922;4926.8768280793265;4969.906620543475;4984.551390374883;4987.875303117451;24342.878285608458;25813;25987.870060649577;26069;26109.477810444063;24128.87935560311;25121;25418;25498.362540936254;25591.48817023649;12547.058970577244;12655.746885062432;12717.491300347883;12736.426860791287;12752.936235318764;9679.854802177832;9762.316637835567;9843.655472058443;9852.211823053995;9877.703668889944;20800.47998800042;20874.269400570905;21069.89465052665;21381;21877.781222187576;22038.787866667488;22304.10783568639;22318.330450086523;22495.437614059778;22556.887215563816;13474.797878032034;13788.655283617989;13794;13796.241206733726;13799.655008624462;15769.526914192593;15772.842271577596;15824.208789560245;15891.28489218011;15900.92049539745;12718.872811271769;12844.486220551447;13046.869531304565;13131.868681313446;13251.80122298147;12516.624501264976;12523.74952500963;12544.87455125437;12629.684257893627;12936.159149655243;10813.51339189754;10851.945740271563;10988.066014388547;11005.1746119043;11037.668869933916;7625.580593067434;7834.960825195838;7854.371650268079;7864.4888082274465;7892.894994700861;8383.748487545383;8683.131686831266;8720.694775682821;8757.47455152693;8777.956110219407 18:19:18 INFO - PID 15362 | |4;prototype.html;533.242795230772;542.4060653584326;558.4834028523615;560.3863769172757;565.5164834066874;6109.327973922865;6158;6173.753049878;6229.750809967607;6241.4070663286975;6084.2090528231265;6113.572049956505;6124.877502449959;6225.688715564215;6233.625982441056;5016.448190699039;5020.196768517038;5051.166557518023;5097.05704444677;5099.260607211952;4956.157453232959;5029.698218106907;5049.697018178921;5056.367954005749;5067.214581739818;4924.753762311888;4962.702237865739;4971.875703107415;4988.226824842155;5035.28094828792;4729.976350118244;4848.903021939542;4854.296127061574;4881.414230292352;4886.193778026622;4431.512533621299;4433.357163211316;4435.112977404532;4443.37792709021;4456;5896.410358964112;5927.37762534932;5973.850653733692;6025.578209525335;6025.855087533399;5689.151025916593;5716.742746576414;5725;5746.109353050284;5794.188813566062;6452.7418903243815;6519.217693876718;6525.510586705968;6530.738770449177;6571.474282057424;4753.762311884392;4955.5044495550155;4977.228529577921;5013.724245166514;5014.197728363481;6643.169603799525;6730.125083739132;6809.761658341934;6813.386795188457;6842.828929276808;5068.366454193226;5086.389633243961;5109.770060347293;5118.667286626357;5140.614453915897;5167.276581278624;5168.534831865075;5204.947950520522;5212.218167274939;5216.66091704038;5648.858778530487;5723.885522289531;5724.711939813508;5749.540036797046;5792.478676919098;6550.508711846631;6554.24721616922;6554.70503827329;6617.602943823386;6619.271880093186;1735.8784885057926;1743.7645917800935;1769.265754711806;1794.6410717856481;1794.7487351770762;1218.4122196099333;1236.190295356543;1248.4007676315418;1268.0806415348798;1282.3011458755002;6021.969890150521;6026.096085587109;6053.545984051214;6092;6142.723577439026;6437.839054023687;6471.870562588721;6516.8292292932565;6548.541602087904;6612;5968.641881487125;5976.471763618722;6030.758769649165;6057.939420605826;6101.633901965896;3357.4292370297107;3416.197193659538;3454.4818277258614;3455.963211036679;3518.7009104226427;6734.1918969722965;6788.660566971632;6839.179298484214;6935.271796461399;6941.7223311068;6645.269020407752;6750.561213521106;6755.864882702318;6761.966190169018;6863.965680171667;6833.760818371333;6867.725290988305;6906.482013849082;6998.2651821558;7009.9299007010295;6493;6507.544471886922;6572.737090516517;6648.639732894752;6674.365935236145;6534.379233972765;6536.431256498501;6592.17597800275;6625.635590042594;6667.66661666905;6722.428593569602;6783.321667833177;6849.931500684929;6884.793456196322;6924.169099708067;5045.747712614281;5067.6199285053035;5079.746012699424;5091.974540127276;5101.234814777813;6373.490120790233;6558.540902136805;6605.438537724155;6647.634380108947;6663.800085997428;6336.714847831767;6357.249222958477;6386.233651961608;6457.806265812033;6476.312330382838;6274.709730948262;6292.339304372975;6339.144215530844;6388.872222555616;6430.164078669743;6132.834761395321;6213.440790328892;6296.560924548091;6322.241331040121;6365.554411191358;6300.731736574738;6382.648954307558;6475.384838440341;6475.514336424882;6495.76580449713;6247.187865577627;6279.905801413074;6313.116163737172;6314.431701146918;6321.336259692666 18:19:18 INFO - PID 15362 | |5;yui.html;937.9108984646458;947.587799307301;986.5412583148834;989.144390102561;994.1549682769643;21021.474463138427;21399.57200855982;21571;21591.56816863662;21615.3515394538;19398;19835.801641983577;20326.186952521883;20352;20419.48951276219;1024.6208902705991;1040.230229630072;1041.4688508860497;1041.5469270867159;1045.028123844824;1051.4479898053507;1065.8934106589318;1076.047697787456;1084.2356138922041;1087.5106202209;1154.6478324111142;1163.0172504233908;1163.6043745126656;1163.9941800290987;1165.580391059218;1096.0519150934424;1122.876483586813;1123.427052203374;1157.4328578996315;1162.4187906046977;822.2763967708438;827.6275675945849;828.5774255129927;828.6519661742083;828.660249297785;20294.898525507277;20357.491062723402;20471.283505077252;20491.79508204914;20492.69260961072;22768;23839.165629202893;23898.522029559485;23933.401664958514;23935.88032059846;18388.448346549623;18948.810511894844;18952.5261868453;18993.715094273597;19110.426687199408;3987.501562304712;4000.5599384067727;4021.4369988201674;4022.1955608878047;4025.657819085381;160360;160962;161756.19121904433;162011;164055;17862.374816881347;18052;18251.72622410665;18304.450866474028;18391.81608183928;35191.29617407689;35330.82334588311;36052.098697532245;36195.09512262162;36295.63704362975;8542.487450752975;8617.870731939025;8631.741047768577;8635.179657932485;8646.870296945552;4549.135664223853;4591.150637132141;4596.7931443085145;4619.745913974763;4639.953600463952;6104.481119104837;6205.317415084337;6215.875682486325;6228.314885362606;6235.625862448268;1106.5739690219323;1110.0675432636624;1128.3906690387098;1129.249049382168;1131.4569006876745;725.0900120348929;734.9669264883094;738.3502517784316;746.9813254668677;752.5409500204871;13200.20798752078;13719.588412347646;14179.078359906573;14721.190334531704;14782.778258326134;713.7965679781238;714.1002337055347;717.659111921833;719.7013239505651;734.9448791340564;6124.173236613089;6208.286047104551;6225.346338634378;6256.499480041586;6261.405166509175;146835.26582367232;147915;148079;149687;157350;134620;134989;136123.31938340442;136604;139318.30340848232;118692;120808;120951.39524302498;121881.39059304824;121898.3905080469;11383.715407114889;11474.139439541901;11608.941955290169;11904.523819047488;11939.701507462383;56477.717611413325;56692.433075670364;57909.71045144916;58089;58564;74591.62704186444;74630.62684686542;75611;76058.23941760512;76417.61791191009;17001.48995530136;17551.648967020843;17877.642447151244;17893.105344732972;18083.54791130232;18845.24619015224;18857.339993100177;18885;19013.049347532844;19115.94862282588;16812.66374672524;17551.648967020334;17608.91195544014;17644.294228230727;17847.553811154827;16866.831331686528;17022.48932532026;17029.233684484476;17083.31666733317;17216.483505494856;17454.563635909202;17700.734488982933;17969.64060718752;18048.909755451663;18178;12354.876451235732;12597.244165350108;12716.046296527613;12770.61688149357;12804.359782011048;12460.252384856938;12704.491820327083;12733.681657958625;13069.803952940903;13098.476060957455 18:19:18 INFO - PID 15362 | __end_tp_report 18:19:18 INFO - PID 15362 | __start_cc_report 18:19:18 INFO - PID 15362 | _x_x_mozilla_cycle_collect,341 18:19:18 INFO - PID 15362 | __end_cc_report 18:19:18 INFO - PID 15362 | __startTimestamp1505351957994__endTimestamp 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | ------- Summary: start ------- 18:19:18 INFO - PID 15362 | Number of tests: 6 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | [#0] dojo.html Cycles:165 Average:6258.96 Median:6452.16 stddev:738.53 (11.4%) stddev-sans-first:715.19 18:19:18 INFO - PID 15362 | Values: 3801.4 3841.2 3881.3 3884.5 3899.8 6178.6 6257.7 6281.7 6304.7 6341.9 6323.1 6326.1 6357.4 6362.7 6364.6 5584.1 5614.3 5640.9 5647.5 5726.6 5711.9 5714.8 5748.2 5753.1 5781.1 5677.0 5688.4 5718.9 5730.1 5769.8 5471.4 5612.4 5619.0 5705.3 5722.4 5586.8 5603.1 5664.1 5664.5 5679.8 6146.7 6188.4 6224.8 6274.1 6347.3 6801.9 6822.9 6833.1 6846.1 6857.0 6797.8 6803.5 6815.9 6888.8 6893.7 6269.3 6365.1 6386.4 6394.6 6425.2 6946.4 6950.9 7004.3 7038.0 7043.4 6575.9 6745.6 6749.1 6756.2 6761.1 6765.6 6777.3 6788.2 6867.5 6893.7 6664.0 6699.6 6729.0 6749.4 6808.8 6702.0 6742.5 6766.5 6783.9 6828.2 4879.5 4996.9 5016.7 5020.8 5023.8 4413.8 4505.6 4508.4 4510.1 4532.0 6248.7 6309.0 6336.9 6348.7 6363.5 6751.1 6756.1 6830.9 6834.3 6845.0 6266.3 6294.5 6346.7 6361.7 6371.5 5416.8 5430.8 5458.6 5484.7 5519.4 6943.5 7007.2 7091.3 7113.5 7125.6 6700.9 6714.6 6780.8 6792.7 6805.5 7018.3 7043.0 7114.4 7117.0 7123.4 6670.9 6693.9 6734.3 6749.0 6753.7 6686.1 6842.3 6850.2 6851.0 6854.8 6452.2 6476.8 6540.4 6558.2 6585.9 6442.8 6476.8 6543.3 6563.0 6588.6 6441.0 6516.5 6538.2 6555.0 6586.8 6463.9 6584.4 6594.6 6665.2 6669.3 6299.4 6389.9 6400.7 6424.1 6448.7 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | [#1] ext.html Cycles:180 Average:43541.52 Median:39453.02 stddev:64890.23 (164.5%) stddev-sans-first:64993.52 18:19:18 INFO - PID 15362 | Values: 966.1 986.0 987.3 991.9 995.9 41992.0 46784.5 46904.3 47008.3 47019.8 42755.6 43075.0 43096.0 43107.6 43145.8 7605.2 8248.8 8436.2 8465.2 8469.7 8247.0 8344.0 8370.3 8372.3 8374.6 8328.7 8391.7 8392.9 8394.5 8396.8 8340.3 8375.2 8385.1 8385.3 8389.0 8234.3 8234.6 8248.0 8283.8 8283.9 40955.4 41012.0 41018.6 41140.2 41162.8 3742.2 3746.7 3771.9 3773.3 3773.9 33859.2 33906.5 33917.7 33935.2 34076.0 5349.2 5472.3 5528.1 5552.3 5589.1 213746.0 214307.0 214938.0 215549.0 215816.0 46840.5 48095.0 52472.0 52529.7 53936.5 58805.7 58974.0 59039.0 59053.7 59085.0 14807.0 14882.6 14887.6 14891.6 14896.6 11653.8 11654.9 11655.0 11666.9 11667.0 15731.9 15762.2 15823.0 15843.2 15894.6 6122.2 6178.6 6210.7 6256.2 6313.7 1084.6 1100.2 1113.6 1119.4 1121.6 25709.0 26172.6 26186.1 26240.6 26422.9 1184.7 1189.6 1193.7 1206.6 1209.0 13686.6 13726.7 13747.5 13799.6 13907.2 275363.0 276439.0 277179.0 277792.0 278052.0 59541.4 59926.0 59977.0 60019.4 60169.4 1507.5 1523.6 1525.6 1547.7 1566.0 25296.4 25407.6 25691.4 25782.7 25830.0 42713.1 42892.1 43023.1 43053.0 43148.0 252133.0 252500.0 253039.0 253278.0 253663.0 37807.2 40796.8 41349.6 41628.0 41778.4 50597.5 52538.7 52803.7 52822.7 52855.7 37292.3 37831.0 37846.6 37993.6 38109.2 37433.4 37536.4 37580.8 37830.4 37854.4 43604.0 43937.1 44324.1 44755.0 44797.0 35985.3 36214.0 36295.5 36310.5 36593.5 27012.6 27017.3 27399.9 27475.9 27682.7 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | [#2] jquery.html Cycles:180 Average:39704.99 Median:23721.76 stddev:100261.29 (422.7%) stddev-sans-first:100499.48 18:19:18 INFO - PID 15362 | Values: 567.2 579.2 581.6 593.1 598.4 22920.2 23693.6 23716.4 23724.6 23734.5 23718.9 25033.6 25364.5 25414.0 25470.6 6503.4 6555.2 6597.6 6599.1 6637.6 6220.0 6411.1 6424.7 6428.8 6429.8 6407.8 6422.6 6428.7 6443.9 6464.5 6470.6 6470.8 6473.4 6474.5 6474.6 5994.4 6008.3 6010.1 6018.2 6045.0 28164.7 29133.6 29272.0 29597.9 29602.1 2222.1 2237.2 2244.6 2246.6 2247.4 19777.9 20439.0 20440.6 20463.8 20489.8 2523.6 2550.1 2600.2 2603.4 2607.4 136196.0 142312.3 148494.0 154387.0 157756.0 15536.6 16069.3 16155.7 16252.3 16351.0 24923.4 24954.3 24963.9 24967.4 24987.4 9446.0 9527.4 9589.3 9663.3 9720.6 8316.3 8346.9 8444.4 8460.2 8517.4 9804.3 9914.0 9981.7 10019.4 10080.9 2876.7 2892.4 2969.3 3025.4 3068.3 1045.3 1050.4 1053.6 1060.7 1061.5 20135.7 20352.2 20485.5 20855.5 21175.4 1069.3 1092.5 1110.8 1114.4 1117.8 11227.0 11338.8 11411.9 11421.7 11509.1 561036.0 588948.0 598583.0 620969.0 622950.0 129289.4 129743.4 132217.3 133026.3 133069.0 1101.7 1215.5 1227.4 1248.7 1273.7 21558.6 21949.2 21952.3 22209.7 22294.6 63866.4 64030.0 67314.7 67857.3 69509.0 79426.0 80945.6 81503.6 82383.6 82985.0 20215.4 20847.0 20893.7 20939.8 20940.2 23743.8 23827.3 23973.4 24074.0 24130.8 17959.0 17969.3 18083.7 18112.3 18860.9 16718.2 17309.6 17389.7 17776.3 17891.2 18701.8 19277.2 19366.2 19596.3 19702.1 20533.6 20548.6 20571.0 20642.0 20715.3 18480.2 18507.6 18828.2 18911.1 18929.3 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | [#3] mootools.html Cycles:180 Average:10690.58 Median:2674.35 stddev:7911.37 (295.8%) stddev-sans-first:7902.99 18:19:18 INFO - PID 15362 | Values: 1432.4 1492.7 1496.0 1500.7 1503.5 16763.8 17439.0 17456.8 17464.1 17468.4 16974.2 17108.3 17114.9 17128.4 17134.0 2889.8 2908.8 2958.5 2959.1 2960.5 2723.2 2732.7 2733.1 2733.2 2737.7 2805.8 2851.2 2855.8 2859.2 2862.1 2658.4 2671.0 2682.6 2683.8 2685.2 2645.5 2674.2 2674.5 2675.2 2676.1 16535.4 16829.2 16840.2 16858.5 16863.0 8463.9 8698.2 8704.7 8725.1 8727.4 5327.2 5485.9 5643.1 5725.7 5824.5 1991.0 1996.7 2012.1 2066.3 2074.5 27560.3 28662.6 29982.0 30956.7 31024.8 7640.7 7654.2 7846.1 8044.2 8082.1 23650.5 23661.8 23662.8 23674.1 23696.4 8952.9 8954.1 8955.1 8956.2 8958.7 7546.1 7773.5 7777.9 7789.1 7790.5 6226.0 6268.6 6367.9 6473.3 6516.5 1813.1 1821.3 1822.5 1833.2 1839.0 985.8 986.6 993.5 996.6 1017.6 9625.1 9720.2 9813.4 9895.4 10051.0 748.9 770.6 777.8 779.3 781.3 4818.4 4926.9 4969.9 4984.6 4987.9 24342.9 25813.0 25987.9 26069.0 26109.5 24128.9 25121.0 25418.0 25498.4 25591.5 12547.1 12655.7 12717.5 12736.4 12752.9 9679.9 9762.3 9843.7 9852.2 9877.7 20800.5 20874.3 21069.9 21381.0 21877.8 22038.8 22304.1 22318.3 22495.4 22556.9 13474.8 13788.7 13794.0 13796.2 13799.7 15769.5 15772.8 15824.2 15891.3 15900.9 12718.9 12844.5 13046.9 13131.9 13251.8 12516.6 12523.7 12544.9 12629.7 12936.2 10813.5 10851.9 10988.1 11005.2 11037.7 7625.6 7835.0 7854.4 7864.5 7892.9 8383.7 8683.1 8720.7 8757.5 8778.0 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | [#4] prototype.html Cycles:180 Average:5521.10 Median:6111.45 stddev:1538.76 (25.2%) stddev-sans-first:1496.84 18:19:18 INFO - PID 15362 | Values: 533.2 542.4 558.5 560.4 565.5 6109.3 6158.0 6173.8 6229.8 6241.4 6084.2 6113.6 6124.9 6225.7 6233.6 5016.4 5020.2 5051.2 5097.1 5099.3 4956.2 5029.7 5049.7 5056.4 5067.2 4924.8 4962.7 4971.9 4988.2 5035.3 4730.0 4848.9 4854.3 4881.4 4886.2 4431.5 4433.4 4435.1 4443.4 4456.0 5896.4 5927.4 5973.9 6025.6 6025.9 5689.2 5716.7 5725.0 5746.1 5794.2 6452.7 6519.2 6525.5 6530.7 6571.5 4753.8 4955.5 4977.2 5013.7 5014.2 6643.2 6730.1 6809.8 6813.4 6842.8 5068.4 5086.4 5109.8 5118.7 5140.6 5167.3 5168.5 5204.9 5212.2 5216.7 5648.9 5723.9 5724.7 5749.5 5792.5 6550.5 6554.2 6554.7 6617.6 6619.3 1735.9 1743.8 1769.3 1794.6 1794.7 1218.4 1236.2 1248.4 1268.1 1282.3 6022.0 6026.1 6053.5 6092.0 6142.7 6437.8 6471.9 6516.8 6548.5 6612.0 5968.6 5976.5 6030.8 6057.9 6101.6 3357.4 3416.2 3454.5 3456.0 3518.7 6734.2 6788.7 6839.2 6935.3 6941.7 6645.3 6750.6 6755.9 6762.0 6864.0 6833.8 6867.7 6906.5 6998.3 7009.9 6493.0 6507.5 6572.7 6648.6 6674.4 6534.4 6536.4 6592.2 6625.6 6667.7 6722.4 6783.3 6849.9 6884.8 6924.2 5045.7 5067.6 5079.7 5092.0 5101.2 6373.5 6558.5 6605.4 6647.6 6663.8 6336.7 6357.2 6386.2 6457.8 6476.3 6274.7 6292.3 6339.1 6388.9 6430.2 6132.8 6213.4 6296.6 6322.2 6365.6 6300.7 6382.6 6475.4 6475.5 6495.8 6247.2 6279.9 6313.1 6314.4 6321.3 18:19:18 INFO - PID 15362 | 18:19:18 INFO - PID 15362 | [#5] yui.html Cycles:180 Average:28865.42 Median:18618.53 stddev:43311.65 (232.6%) stddev-sans-first:43382.38 18:19:18 INFO - PID 15362 | Values: 937.9 947.6 986.5 989.1 994.2 21021.5 21399.6 21571.0 21591.6 21615.4 19398.0 19835.8 20326.2 20352.0 20419.5 1024.6 1040.2 1041.5 1041.5 1045.0 1051.4 1065.9 1076.0 1084.2 1087.5 1154.6 1163.0 1163.6 1164.0 1165.6 1096.1 1122.9 1123.4 1157.4 1162.4 822.3 827.6 828.6 828.7 828.7 20294.9 20357.5 20471.3 20491.8 20492.7 22768.0 23839.2 23898.5 23933.4 23935.9 18388.4 18948.8 18952.5 18993.7 19110.4 3987.5 4000.6 4021.4 4022.2 4025.7 160360.0 160962.0 161756.2 162011.0 164055.0 17862.4 18052.0 18251.7 18304.5 18391.8 35191.3 35330.8 36052.1 36195.1 36295.6 8542.5 8617.9 8631.7 8635.2 8646.9 4549.1 4591.2 4596.8 4619.7 4640.0 6104.5 6205.3 6215.9 6228.3 6235.6 1106.6 1110.1 1128.4 1129.2 1131.5 725.1 735.0 738.4 747.0 752.5 13200.2 13719.6 14179.1 14721.2 14782.8 713.8 714.1 717.7 719.7 734.9 6124.2 6208.3 6225.3 6256.5 6261.4 146835.3 147915.0 148079.0 149687.0 157350.0 134620.0 134989.0 136123.3 136604.0 139318.3 118692.0 120808.0 120951.4 121881.4 121898.4 11383.7 11474.1 11608.9 11904.5 11939.7 56477.7 56692.4 57909.7 58089.0 58564.0 74591.6 74630.6 75611.0 76058.2 76417.6 17001.5 17551.6 17877.6 17893.1 18083.5 18845.2 18857.3 18885.0 19013.0 19115.9 16812.7 17551.6 17608.9 17644.3 17847.6 16866.8 17022.5 17029.2 17083.3 17216.5 17454.6 17700.7 17969.6 18048.9 18178.0 12354.9 12597.2 12716.0 12770.6 12804.4 12460.3 12704.5 12733.7 13069.8 13098.5 18:19:18 INFO - PID 15362 | -------- Summary: end -------- 18:19:18 INFO - PID 15362 | 18:19:18 INFO - TEST-INFO | 15362: exit 0 18:19:18 INFO - TEST-OK | dromaeo_css | took 1108043ms 18:19:18 INFO - TEST-START | kraken 18:19:18 INFO - Initialising browser for kraken test... 18:19:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44848/getInfo.html -profile /tmp/tmpozRmIW/profile 18:19:18 INFO - TEST-INFO | started process 15733 (/builds/slave/test/build/application/firefox/firefox http://localhost:44848/getInfo.html) 18:19:23 INFO - TEST-INFO | 15733: exit 0 18:19:24 INFO - Browser initialized. 18:19:24 INFO - Running cycle 1/1 for kraken test... 18:19:24 INFO - Using env: {'DISPLAY': ':0', 18:19:24 INFO - 'HOME': '/home/cltbld', 18:19:24 INFO - 'JSGC_DISABLE_POISONING': '1', 18:19:24 INFO - 'LANG': 'en_US.UTF-8', 18:19:24 INFO - 'LANGUAGE': 'en_US:en', 18:19:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:19:24 INFO - 'LOGNAME': 'cltbld', 18:19:24 INFO - 'MAIL': '/var/mail/cltbld', 18:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:24 INFO - 'MOZ_CRASHREPORTER': '1', 18:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:19:24 INFO - 'MOZ_NO_REMOTE': '1', 18:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:24 INFO - 'NO_EM_RESTART': '1', 18:19:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:24 INFO - 'PWD': '/builds/slave/test', 18:19:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:24 INFO - 'RUST_BACKTRACE': 'full', 18:19:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:19:24 INFO - 'SHELL': '/bin/bash', 18:19:24 INFO - 'SHLVL': '1', 18:19:24 INFO - 'STYLO_FORCE_DISABLED': '1', 18:19:24 INFO - 'TERM': 'linux', 18:19:24 INFO - 'TMOUT': '86400', 18:19:24 INFO - 'USER': 'cltbld', 18:19:24 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730', 18:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:24 INFO - '_': '/tools/buildbot/bin/python'} 18:19:24 INFO - TEST-INFO | started process 15970 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpozRmIW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:24 INFO - PID 15970 | 18:19:24 INFO - PID 15970 | (/builds/slave/test/build/application/firefox/firefox:16019): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:19:24 INFO - PID 15970 | 18:19:35 INFO - PID 15970 | RSS: Main: 161370112 18:19:35 INFO - PID 15970 | 18:19:37 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-beat-detection) 18:19:38 INFO - PID 15970 | RSS: Main: 166789120 18:19:38 INFO - PID 15970 | 18:19:41 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-dft) 18:19:41 INFO - PID 15970 | RSS: Main: 166952960 18:19:41 INFO - PID 15970 | 18:19:44 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-fft) 18:19:45 INFO - PID 15970 | RSS: Main: 162643968 18:19:45 INFO - PID 15970 | 18:19:47 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44848/tests/kraken/driver.html?testName=audio-oscillator) 18:19:48 INFO - PID 15970 | RSS: Main: 163655680 18:19:48 INFO - PID 15970 | 18:19:50 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:19:50 INFO - PID 15970 | RSS: Main: 163573760 18:19:50 INFO - PID 15970 | 18:19:53 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44848/tests/kraken/driver.html?testName=imaging-darkroom) 18:19:54 INFO - PID 15970 | RSS: Main: 163835904 18:19:54 INFO - PID 15970 | 18:19:58 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44848/tests/kraken/driver.html?testName=imaging-desaturate) 18:19:58 INFO - PID 15970 | RSS: Main: 166232064 18:19:58 INFO - PID 15970 | 18:20:01 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44848/tests/kraken/driver.html?testName=json-parse-financial) 18:20:02 INFO - PID 15970 | RSS: Main: 166666240 18:20:02 INFO - PID 15970 | 18:20:03 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:20:04 INFO - PID 15970 | RSS: Main: 166653952 18:20:04 INFO - PID 15970 | 18:20:05 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:20:06 INFO - PID 15970 | RSS: Main: 166367232 18:20:06 INFO - PID 15970 | 18:20:08 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:20:09 INFO - PID 15970 | RSS: Main: 166662144 18:20:09 INFO - PID 15970 | 18:20:11 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:20:12 INFO - PID 15970 | RSS: Main: 166866944 18:20:12 INFO - PID 15970 | 18:20:14 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:20:15 INFO - PID 15970 | RSS: Main: 167346176 18:20:15 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | Cycle 1(1): loaded http://localhost:44848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44848/tests/kraken/driver.html?testName=ai-astar) 18:20:17 INFO - PID 15970 | RSS: Main: 169009152 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | __start_tp_report 18:20:17 INFO - PID 15970 | _x_x_mozilla_page_load 18:20:17 INFO - PID 15970 | _x_x_mozilla_page_load_details 18:20:17 INFO - PID 15970 | |i|pagename|runs| 18:20:17 INFO - PID 15970 | |0;ai-astar;105;104;106;105;108;108;107;106;106;105 18:20:17 INFO - PID 15970 | |1;audio-beat-detection;114;112;110;111;117;111;115;123;112;139 18:20:17 INFO - PID 15970 | |2;audio-dft;162;163;162;161;161;164;163;163;166;171 18:20:17 INFO - PID 15970 | |3;audio-fft;73;74;73;72;74;74;73;73;74;72 18:20:17 INFO - PID 15970 | |4;audio-oscillator;79;79;77;77;85;76;77;78;79;78 18:20:17 INFO - PID 15970 | |5;imaging-gaussian-blur;113;115;114;117;117;109;113;114;114;113 18:20:17 INFO - PID 15970 | |6;imaging-darkroom;149;152;149;150;149;148;149;150;150;150 18:20:17 INFO - PID 15970 | |7;imaging-desaturate;94;93;93;94;93;94;93;94;96;94 18:20:17 INFO - PID 15970 | |8;json-parse-financial;44;46;43;43;44;45;43;45;45;45 18:20:17 INFO - PID 15970 | |9;json-stringify-tinderbox;40;40;40;39;39;39;40;39;39;39 18:20:17 INFO - PID 15970 | |10;stanford-crypto-aes;71;71;71;75;74;74;71;70;70;71 18:20:17 INFO - PID 15970 | |11;stanford-crypto-ccm;112;104;118;111;105;106;109;112;106;111 18:20:17 INFO - PID 15970 | |12;stanford-crypto-pbkdf2;162;160;155;155;158;148;160;162;150;152 18:20:17 INFO - PID 15970 | |13;stanford-crypto-sha256-iterative;63;63;59;60;60;59;60;62;57;61 18:20:17 INFO - PID 15970 | __end_tp_report 18:20:17 INFO - PID 15970 | __start_cc_report 18:20:17 INFO - PID 15970 | _x_x_mozilla_cycle_collect,904 18:20:17 INFO - PID 15970 | __end_cc_report 18:20:17 INFO - PID 15970 | __startTimestamp1505352017549__endTimestamp 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | ------- Summary: start ------- 18:20:17 INFO - PID 15970 | Number of tests: 14 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#0] ai-astar Cycles:10 Average:106.00 Median:106.00 stddev:1.33 (1.3%) stddev-sans-first:1.36 18:20:17 INFO - PID 15970 | Values: 105.0 104.0 106.0 105.0 108.0 108.0 107.0 106.0 106.0 105.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:114.50 stddev:8.82 (7.7%) stddev-sans-first:9.31 18:20:17 INFO - PID 15970 | Values: 114.0 112.0 110.0 111.0 117.0 111.0 115.0 123.0 112.0 139.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.99 (1.8%) stddev-sans-first:3.11 18:20:17 INFO - PID 15970 | Values: 162.0 163.0 162.0 161.0 161.0 164.0 163.0 163.0 166.0 171.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#3] audio-fft Cycles:10 Average:73.20 Median:73.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 18:20:17 INFO - PID 15970 | Values: 73.0 74.0 73.0 72.0 74.0 74.0 73.0 73.0 74.0 72.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:78.50 stddev:2.51 (3.2%) stddev-sans-first:2.65 18:20:17 INFO - PID 15970 | Values: 79.0 79.0 77.0 77.0 85.0 76.0 77.0 78.0 79.0 78.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:2.28 (2.0%) stddev-sans-first:2.40 18:20:17 INFO - PID 15970 | Values: 113.0 115.0 114.0 117.0 117.0 109.0 113.0 114.0 114.0 113.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 18:20:17 INFO - PID 15970 | Values: 149.0 152.0 149.0 150.0 149.0 148.0 149.0 150.0 150.0 150.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 18:20:17 INFO - PID 15970 | Values: 94.0 93.0 93.0 94.0 93.0 94.0 93.0 94.0 96.0 94.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#8] json-parse-financial Cycles:10 Average:44.30 Median:45.00 stddev:1.06 (2.4%) stddev-sans-first:1.12 18:20:17 INFO - PID 15970 | Values: 44.0 46.0 43.0 43.0 44.0 45.0 43.0 45.0 45.0 45.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.50 stddev:0.52 (1.3%) stddev-sans-first:0.50 18:20:17 INFO - PID 15970 | Values: 40.0 40.0 40.0 39.0 39.0 39.0 40.0 39.0 39.0 39.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:71.00 stddev:1.81 (2.6%) stddev-sans-first:1.90 18:20:17 INFO - PID 15970 | Values: 71.0 71.0 71.0 75.0 74.0 74.0 71.0 70.0 70.0 71.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#11] stanford-crypto-ccm Cycles:10 Average:109.40 Median:111.00 stddev:4.27 (3.9%) stddev-sans-first:4.43 18:20:17 INFO - PID 15970 | Values: 112.0 104.0 118.0 111.0 105.0 106.0 109.0 112.0 106.0 111.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:159.00 stddev:5.01 (3.1%) stddev-sans-first:4.85 18:20:17 INFO - PID 15970 | Values: 162.0 160.0 155.0 155.0 158.0 148.0 160.0 162.0 150.0 152.0 18:20:17 INFO - PID 15970 | 18:20:17 INFO - PID 15970 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.40 Median:60.50 stddev:1.90 (3.1%) stddev-sans-first:1.76 18:20:17 INFO - PID 15970 | Values: 63.0 63.0 59.0 60.0 60.0 59.0 60.0 62.0 57.0 61.0 18:20:17 INFO - PID 15970 | -------- Summary: end -------- 18:20:17 INFO - PID 15970 | 18:20:18 INFO - PID 15970 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:20:18 INFO - TEST-INFO | 15970: exit 0 18:20:18 INFO - TEST-OK | kraken | took 59781ms 18:20:18 INFO - SUITE-END | took 1167s 18:20:18 INFO - Completed test suite (00:19:28) 18:20:18 INFO - javascript benchmark 18:20:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9091.029444057045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3801.3537698591244, 3841.23175364927, 3881.26256011358, 3884.4755957945667, 3899.805009749512, 6178.598391104586, 6257.71840267188, 6281.685915704214, 6304.71628776705, 6341.873162536746, 6323.114763933041, 6326.145970294009, 6357.3642635736405, 6362.745490180388, 6364.554481186319, 5584.078627026536, 5614.2701448811595, 5640.943590564103, 5647.463490968352, 5726.570507211955, 5711.857203569903, 5714.799982000631, 5748.223989761392, 5753.050746626802, 5781.103928891029, 5677.0, 5688.4311568843195, 5718.942810571883, 5730.111832665943, 5769.798057068004, 5471.398146203915, 5612.438756124355, 5619.044762390404, 5705.315362156526, 5722.4277572242445, 5586.776528938837, 5603.131514615241, 5664.122061080498, 5664.461876121762, 5679.772809087632, 6146.66193359365, 6188.350223226586, 6224.813255602339, 6274.121622972787, 6347.333529979378, 6801.863962720768, 6822.863542729167, 6833.077534532824, 6846.075779769717, 6857.040014397989, 6797.796066118024, 6803.523753337268, 6815.931840681579, 6888.827779305508, 6893.724251030003, 6269.310375858652, 6365.077063825719, 6386.393292637145, 6394.6482943438095, 6425.1968503937005, 6946.374826265559, 6950.895736563955, 7004.264552221944, 7038.0, 7043.36609705129, 6575.868482630416, 6745.5952642841585, 6749.0888730020815, 6756.223034351015, 6761.053452516651, 6765.627890465973, 6777.2545020047755, 6788.185417749902, 6867.450603951672, 6893.724251030003, 6664.0, 6699.631520266432, 6728.966355168192, 6749.358810912955, 6808.829779255559, 6701.966490167615, 6742.5280230383405, 6766.5263431559315, 6783.932160678429, 6828.2147553031045, 4879.463259041502, 4996.850094497171, 5016.724080175625, 5020.799168033238, 5023.79904803811, 4413.823447062082, 4505.617022553054, 4508.391367165391, 4510.075434535912, 4531.977340113278, 6248.718807653576, 6309.0, 6336.873262534816, 6348.746050157942, 6363.522735794834, 6751.0886030386255, 6756.087928129639, 6830.897536536956, 6834.316568343225, 6845.041694162821, 6266.310705822356, 6294.464970477561, 6346.682665866781, 6361.745530178833, 6371.458426033746, 5416.83749487516, 5430.755615997211, 5458.61789674719, 5484.698341591171, 5519.448055194448, 6943.548669336477, 7007.194172670106, 7091.2554181810165, 7113.466490013269, 7125.608091554911, 6700.899486507608, 6714.597124172566, 6780.762673306411, 6792.660366981631, 6805.455563555002, 7018.298170182941, 7042.964785176041, 7114.359707626339, 7117.039199707973, 7123.394511466583, 6670.899936500859, 6693.899591506229, 6734.326567343226, 6749.0, 6753.696083676345, 6686.13080299558, 6842.315768423118, 6850.21222559412, 6850.965745171242, 6854.794356169323, 6452.161219041494, 6476.838079048061, 6540.444062254762, 6558.213014438298, 6585.934140658532, 6442.806715798533, 6476.838079048061, 6543.345665433419, 6563.0, 6588.637624930483, 6441.0, 6516.51126165549, 6538.1827271591055, 6555.049517819984, 6586.769463068769, 6463.870722585428, 6584.440322572635, 6594.604323740591, 6665.233498147775, 6669.2997235289595, 6299.401556852092, 6389.8722025560155, 6400.743970241325, 6424.10062591247, 6448.742050318122], "value": 6208.888273888346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.1449617088876, 985.9605615775374, 987.289151810696, 991.8660980767598, 995.9352642078264, 41992.0, 46784.53215467844, 46904.29643555349, 47008.29487557685, 47019.764901175535, 42755.572444275545, 43075.0, 43096.0, 43107.56892431075, 43145.78427107868, 7605.2014538473495, 8248.83502329953, 8436.240738333549, 8465.153484651548, 8469.74590762275, 8246.958765206165, 8344.040435349953, 8370.288525475342, 8372.28835548979, 8374.581270936429, 8328.708495202638, 8391.70629027984, 8392.874106888401, 8394.454360466581, 8396.790080248013, 8340.29107525858, 8375.20435558621, 8385.119562445978, 8385.287250583708, 8389.035260944978, 8234.258916697527, 8234.629441675139, 8248.0, 8283.751487455385, 8283.875741863876, 40955.385669214986, 41012.0, 41018.589814101775, 41140.1771964562, 41162.79418602888, 3742.1954279829697, 3746.737728359016, 3771.924561508782, 3773.2830762155377, 3773.8867833965023, 33859.15352116192, 33906.49140262898, 33917.66082339195, 33935.15162120942, 34076.0, 5349.197620356938, 5472.288602481652, 5528.143137813645, 5552.278203833516, 5589.077802162638, 213746.0, 214307.0, 214938.0, 215549.0, 215816.0, 46840.5315946843, 48095.0, 52472.0, 52529.737351313, 53936.46063539393, 58805.70597146987, 58974.0, 59039.0, 59053.70473147607, 59085.0, 14807.0375425597, 14882.627934301512, 14887.627809304853, 14891.627709307353, 14896.62758431048, 11653.834616538279, 11654.941725291319, 11655.0, 11666.88333116658, 11667.0, 15731.921340393224, 15762.211889405713, 15823.0, 15843.207839607974, 15894.602634933988, 6122.245089615747, 6178.567500274938, 6210.72051757672, 6256.155419018374, 6313.652749098844, 1084.5661735305941, 1100.1638754546443, 1113.6325012745774, 1119.3619636807105, 1121.5850135449937, 25709.0, 26172.607410888853, 26186.08348707786, 26240.60639090415, 26422.86788566045, 1184.7452797648375, 1189.5776999165346, 1193.731410432663, 1206.631977246948, 1208.9516419343129, 13686.589402317946, 13726.65683357924, 13747.450101996008, 13799.586012419644, 13907.23510206928, 275363.0, 276439.0, 277179.0, 277792.0, 278052.0, 59541.40458595445, 59926.0, 59977.0, 60019.39980600226, 60169.398306017254, 1507.5025241670442, 1523.5657837516476, 1525.6185953511622, 1547.7214101461846, 1566.0134115507158, 25296.39927915669, 25407.6188857171, 25691.35771605725, 25782.742172578033, 25830.0, 42713.145737084466, 42892.14215715731, 43023.1395372097, 43053.0, 43148.0, 252133.0, 252500.0, 253039.0, 253278.0, 253663.0, 37807.24385512329, 40796.79601602092, 41349.586504134575, 41628.0, 41778.37332439955, 50597.494025060754, 52538.73730631475, 52803.73598131985, 52822.73588632032, 52855.73572132115, 37292.254154916205, 37831.0, 37846.62153378431, 37993.62006379901, 38109.23781524299, 37433.43849842309, 37536.43695344627, 37580.81209594044, 37830.43254351242, 37854.43218351782, 43604.0, 43937.12125757531, 44324.11351773011, 44755.0, 44797.0, 35985.28029439449, 36214.0, 36295.45556816597, 36310.455343170404, 36593.45109823408, 27012.594811077455, 27017.3245668852, 27399.863000685666, 27475.86262068677, 27682.723172768016], "value": 19011.4165557854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.239898535962, 579.1660009586193, 581.5603543136544, 593.1281016905149, 598.389642564584, 22920.197793077245, 23693.644595331083, 23716.407089822762, 23724.64413033806, 23734.525309493798, 23718.88140559299, 25033.62449563258, 25364.492710145787, 25414.0, 25470.617940730903, 6503.414692677658, 6555.213374395055, 6597.637129957874, 6599.076129341896, 6637.601743895358, 6219.9689001554925, 6411.070394792752, 6424.743010279583, 6428.8071357859335, 6429.8392540186405, 6407.8398040048905, 6422.614643121405, 6428.742850285983, 6443.871122577546, 6464.450521705638, 6470.644114573673, 6470.802901463221, 6473.417392434656, 6474.514411419115, 6474.579152355105, 5994.37059108796, 6008.279006519202, 6010.128531362971, 6018.217631707894, 6045.0, 28164.718352816413, 29133.56299655507, 29272.0, 29597.852010739807, 29602.111936641933, 2222.0556263588073, 2237.205791943869, 2244.5623103494827, 2246.5619204255177, 2247.404437823978, 19777.9011104945, 20439.0, 20440.591188176302, 20463.795362046487, 20489.795102049087, 2523.621456781479, 2550.0692247329775, 2600.2069368842494, 2603.3621762668267, 2607.361196506868, 136196.0, 142312.28843855715, 148494.0, 154387.0, 157755.99999999886, 15536.611584710246, 16069.276882540315, 16155.676886462204, 16252.349906003863, 16351.0, 24923.376915576893, 24954.251372458857, 24963.87518062398, 24967.375815604755, 24987.375315616893, 9445.952770236105, 9527.38072025316, 9589.280803939733, 9663.323567350219, 9720.562574684156, 8316.334693224528, 8346.874796878052, 8444.408891377545, 8460.153984601613, 8517.44636598619, 9804.264680149017, 9913.950430247802, 9981.700548983543, 10019.448930308903, 10080.925317778001, 2876.6548014238006, 2892.4070565534016, 2969.302213979713, 3025.3949210157616, 3068.2942923127357, 1045.2630895218851, 1050.4432650695144, 1053.5680371047833, 1060.6977011551671, 1061.4692653673164, 20135.697964530544, 20352.18591256333, 20485.48786280325, 20855.47861303449, 21175.36473905785, 1069.315637991686, 1092.4865313302735, 1110.7556337605713, 1114.3815182573749, 1117.7987962166887, 11227.045701115496, 11338.773224535464, 11411.885881141248, 11421.714457138472, 11509.136814738928, 561036.0, 588948.0, 598583.0, 620969.0, 622950.0, 129289.35355323351, 129743.35128324486, 132217.33891330482, 133026.33486832504, 133069.0, 1101.6970333158285, 1215.5016443258398, 1227.4169769359482, 1248.731522722619, 1273.7006803401193, 21558.568828623655, 21949.231776887733, 21952.341429757133, 22209.666854996864, 22294.554108918055, 63866.3613363879, 64030.0, 67314.66342668256, 67857.3214267851, 69509.0, 79426.0, 80945.59527202326, 81503.59248203959, 82383.5880820592, 82985.0, 20215.39353819388, 20847.0, 20893.686594700786, 20939.790602094392, 20940.162393504088, 23743.81280935981, 23827.285181444586, 23973.400664983514, 24074.037038518964, 24130.758692413554, 17959.0, 17969.281228750704, 18083.728744068587, 18112.275508979492, 18860.905695471436, 16718.247678854237, 17309.56726081858, 17389.739153912447, 17776.288948441917, 17891.19489622996, 18701.812981870553, 19277.22891084341, 19366.225350985802, 19596.314129005415, 19702.1134048971, 20533.589328213053, 20548.589028219652, 20571.0, 20642.0, 20715.27496537614, 18480.16839242264, 18507.629847403245, 18828.152733127317, 18911.054447277857, 18929.33747318837], "value": 12756.2238819322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.3769160415218, 1492.723846088473, 1496.0126316631026, 1500.707362064397, 1503.4512402972919, 16763.83236167638, 17439.0, 17456.825431745678, 17464.126793660314, 17468.388606398777, 16974.236159372827, 17108.31566737332, 17114.914425427887, 17128.400505982292, 17134.0, 2889.8410587417684, 2908.8400137992403, 2958.5118455454826, 2959.1270575180265, 2960.48191566475, 2723.2102690219813, 2732.6857411397746, 2733.1390611957268, 2733.221032005879, 2737.712540183282, 2805.775537956969, 2851.158908122109, 2855.8286502809897, 2859.1994241612383, 2862.0984389917107, 2658.3885706287565, 2670.971675904771, 2682.637843891079, 2683.8121331506804, 2685.194441667492, 2645.470905818844, 2674.2378422149595, 2674.4651069785928, 2675.1840688589973, 2676.076753520052, 16535.421260255953, 16829.158542072848, 16840.157992100347, 16858.49424517254, 16863.0, 8463.915360846375, 8698.21716045559, 8704.695335663222, 8725.127487251288, 8727.432716873383, 5327.200919862013, 5485.890282194334, 5643.068893632546, 5725.742341594597, 5824.475797178232, 1990.9502262443555, 1996.7304413904228, 2012.1448384436555, 2066.3284432559326, 2074.543600407923, 27560.310992225153, 28662.570061449096, 29982.0, 30956.69043309583, 31024.844875775703, 7640.73257435987, 7654.158042615308, 7846.136924938252, 8044.1955804419085, 8082.110967793538, 23650.526989460457, 23661.7633823663, 23662.7633723664, 23674.053037878635, 23696.40758981005, 8952.8657070144, 8954.059823718546, 8955.059718729439, 8956.238719708768, 8958.731238062868, 7546.094468663686, 7773.455858089879, 7777.922220777833, 7789.065312162576, 7790.5325680459355, 6226.0, 6268.592541484789, 6367.90448143269, 6473.28793832678, 6516.511261655395, 1813.1478205243513, 1821.2805941652973, 1822.5261432027503, 1833.2208811255164, 1838.981610183881, 985.8225519406576, 986.6497393425374, 993.5082134343546, 996.6013594562233, 1017.6082208349839, 9625.133737963617, 9720.173785228335, 9813.362131461432, 9895.356801807859, 10051.0, 748.8839229919371, 770.6146926536732, 777.766669998998, 779.3219898688178, 781.2656103262915, 4818.445878723922, 4926.8768280793265, 4969.906620543475, 4984.551390374883, 4987.875303117451, 24342.878285608458, 25813.0, 25987.870060649577, 26069.0, 26109.477810444063, 24128.87935560311, 25121.0, 25418.0, 25498.362540936254, 25591.48817023649, 12547.058970577244, 12655.746885062432, 12717.491300347883, 12736.426860791287, 12752.936235318764, 9679.854802177832, 9762.316637835567, 9843.655472058443, 9852.211823053995, 9877.703668889944, 20800.47998800042, 20874.269400570905, 21069.89465052665, 21381.0, 21877.781222187576, 22038.787866667488, 22304.10783568639, 22318.330450086523, 22495.437614059778, 22556.887215563816, 13474.797878032034, 13788.655283617989, 13794.0, 13796.241206733726, 13799.655008624462, 15769.526914192593, 15772.842271577596, 15824.208789560245, 15891.28489218011, 15900.92049539745, 12718.872811271769, 12844.486220551447, 13046.869531304565, 13131.868681313446, 13251.80122298147, 12516.624501264976, 12523.74952500963, 12544.87455125437, 12629.684257893627, 12936.159149655243, 10813.51339189754, 10851.945740271563, 10988.066014388547, 11005.1746119043, 11037.668869933916, 7625.580593067434, 7834.960825195838, 7854.371650268079, 7864.4888082274465, 7892.894994700861, 8383.748487545383, 8683.131686831266, 8720.694775682821, 8757.47455152693, 8777.956110219407], "value": 7401.536712613327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.242795230772, 542.4060653584326, 558.4834028523615, 560.3863769172757, 565.5164834066874, 6109.327973922865, 6158.0, 6173.753049878, 6229.750809967607, 6241.4070663286975, 6084.2090528231265, 6113.572049956505, 6124.877502449959, 6225.688715564215, 6233.625982441056, 5016.448190699039, 5020.196768517038, 5051.166557518023, 5097.05704444677, 5099.260607211952, 4956.157453232959, 5029.698218106907, 5049.697018178921, 5056.367954005749, 5067.214581739818, 4924.753762311888, 4962.702237865739, 4971.875703107415, 4988.226824842155, 5035.28094828792, 4729.976350118244, 4848.903021939542, 4854.296127061574, 4881.414230292352, 4886.193778026622, 4431.512533621299, 4433.357163211316, 4435.112977404532, 4443.37792709021, 4456.0, 5896.410358964112, 5927.37762534932, 5973.850653733692, 6025.578209525335, 6025.855087533399, 5689.151025916593, 5716.742746576414, 5725.0, 5746.109353050284, 5794.188813566062, 6452.7418903243815, 6519.217693876718, 6525.510586705968, 6530.738770449177, 6571.474282057424, 4753.762311884392, 4955.5044495550155, 4977.228529577921, 5013.724245166514, 5014.197728363481, 6643.169603799525, 6730.125083739132, 6809.761658341934, 6813.386795188457, 6842.828929276808, 5068.366454193226, 5086.389633243961, 5109.770060347293, 5118.667286626357, 5140.614453915897, 5167.276581278624, 5168.534831865075, 5204.947950520522, 5212.218167274939, 5216.66091704038, 5648.858778530487, 5723.885522289531, 5724.711939813508, 5749.540036797046, 5792.478676919098, 6550.508711846631, 6554.24721616922, 6554.70503827329, 6617.602943823386, 6619.271880093186, 1735.8784885057926, 1743.7645917800935, 1769.265754711806, 1794.6410717856481, 1794.7487351770762, 1218.4122196099333, 1236.190295356543, 1248.4007676315418, 1268.0806415348798, 1282.3011458755002, 6021.969890150521, 6026.096085587109, 6053.545984051214, 6092.0, 6142.723577439026, 6437.839054023687, 6471.870562588721, 6516.8292292932565, 6548.541602087904, 6612.0, 5968.641881487125, 5976.471763618722, 6030.758769649165, 6057.939420605826, 6101.633901965896, 3357.4292370297107, 3416.197193659538, 3454.4818277258614, 3455.963211036679, 3518.7009104226427, 6734.1918969722965, 6788.660566971632, 6839.179298484214, 6935.271796461399, 6941.7223311068, 6645.269020407752, 6750.561213521106, 6755.864882702318, 6761.966190169018, 6863.965680171667, 6833.760818371333, 6867.725290988305, 6906.482013849082, 6998.2651821558, 7009.9299007010295, 6493.0, 6507.544471886922, 6572.737090516517, 6648.639732894752, 6674.365935236145, 6534.379233972765, 6536.431256498501, 6592.17597800275, 6625.635590042594, 6667.66661666905, 6722.428593569602, 6783.321667833177, 6849.931500684929, 6884.793456196322, 6924.169099708067, 5045.747712614281, 5067.6199285053035, 5079.746012699424, 5091.974540127276, 5101.234814777813, 6373.490120790233, 6558.540902136805, 6605.438537724155, 6647.634380108947, 6663.800085997428, 6336.714847831767, 6357.249222958477, 6386.233651961608, 6457.806265812033, 6476.312330382838, 6274.709730948262, 6292.339304372975, 6339.144215530844, 6388.872222555616, 6430.164078669743, 6132.834761395321, 6213.440790328892, 6296.560924548091, 6322.241331040121, 6365.554411191358, 6300.731736574738, 6382.648954307558, 6475.384838440341, 6475.514336424882, 6495.76580449713, 6247.187865577627, 6279.905801413074, 6313.116163737172, 6314.431701146918, 6321.336259692666], "value": 5077.140564397021, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.9108984646458, 947.587799307301, 986.5412583148834, 989.144390102561, 994.1549682769643, 21021.474463138427, 21399.57200855982, 21571.0, 21591.56816863662, 21615.3515394538, 19398.0, 19835.801641983577, 20326.186952521883, 20352.0, 20419.48951276219, 1024.6208902705991, 1040.230229630072, 1041.4688508860497, 1041.5469270867159, 1045.028123844824, 1051.4479898053507, 1065.8934106589318, 1076.047697787456, 1084.2356138922041, 1087.5106202209, 1154.6478324111142, 1163.0172504233908, 1163.6043745126656, 1163.9941800290987, 1165.580391059218, 1096.0519150934424, 1122.876483586813, 1123.427052203374, 1157.4328578996315, 1162.4187906046977, 822.2763967708438, 827.6275675945849, 828.5774255129927, 828.6519661742083, 828.660249297785, 20294.898525507277, 20357.491062723402, 20471.283505077252, 20491.79508204914, 20492.69260961072, 22768.0, 23839.165629202893, 23898.522029559485, 23933.401664958514, 23935.88032059846, 18388.448346549623, 18948.810511894844, 18952.5261868453, 18993.715094273597, 19110.426687199408, 3987.501562304712, 4000.5599384067727, 4021.4369988201674, 4022.1955608878047, 4025.657819085381, 160360.0, 160962.0, 161756.19121904433, 162011.0, 164055.0, 17862.374816881347, 18052.0, 18251.72622410665, 18304.450866474028, 18391.81608183928, 35191.29617407689, 35330.82334588311, 36052.098697532245, 36195.09512262162, 36295.63704362975, 8542.487450752975, 8617.870731939025, 8631.741047768577, 8635.179657932485, 8646.870296945552, 4549.135664223853, 4591.150637132141, 4596.7931443085145, 4619.745913974763, 4639.953600463952, 6104.481119104837, 6205.317415084337, 6215.875682486325, 6228.314885362606, 6235.625862448268, 1106.5739690219323, 1110.0675432636624, 1128.3906690387098, 1129.249049382168, 1131.4569006876745, 725.0900120348929, 734.9669264883094, 738.3502517784316, 746.9813254668677, 752.5409500204871, 13200.20798752078, 13719.588412347646, 14179.078359906573, 14721.190334531704, 14782.778258326134, 713.7965679781238, 714.1002337055347, 717.659111921833, 719.7013239505651, 734.9448791340564, 6124.173236613089, 6208.286047104551, 6225.346338634378, 6256.499480041586, 6261.405166509175, 146835.26582367232, 147915.0, 148079.0, 149687.0, 157350.0, 134620.0, 134989.0, 136123.31938340442, 136604.0, 139318.30340848232, 118692.0, 120808.0, 120951.39524302498, 121881.39059304824, 121898.3905080469, 11383.715407114889, 11474.139439541901, 11608.941955290169, 11904.523819047488, 11939.701507462383, 56477.717611413325, 56692.433075670364, 57909.71045144916, 58089.0, 58564.0, 74591.62704186444, 74630.62684686542, 75611.0, 76058.23941760512, 76417.61791191009, 17001.48995530136, 17551.648967020843, 17877.642447151244, 17893.105344732972, 18083.54791130232, 18845.24619015224, 18857.339993100177, 18885.0, 19013.049347532844, 19115.94862282588, 16812.66374672524, 17551.648967020334, 17608.91195544014, 17644.294228230727, 17847.553811154827, 16866.831331686528, 17022.48932532026, 17029.233684484476, 17083.31666733317, 17216.483505494856, 17454.563635909202, 17700.734488982933, 17969.64060718752, 18048.909755451663, 18178.0, 12354.876451235732, 12597.244165350108, 12716.046296527613, 12770.61688149357, 12804.359782011048, 12460.252384856938, 12704.491820327083, 12733.681657958625, 13069.803952940903, 13098.476060957455], "value": 9976.056420522547, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1376.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 106.0, 105.0, 108.0, 108.0, 107.0, 106.0, 106.0, 105.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 110.0, 111.0, 117.0, 111.0, 115.0, 123.0, 112.0, 139.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 161.0, 164.0, 163.0, 163.0, 166.0, 171.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 72.0, 74.0, 74.0, 73.0, 73.0, 74.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 77.0, 85.0, 76.0, 77.0, 78.0, 79.0, 78.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 117.0, 117.0, 109.0, 113.0, 114.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 149.0, 150.0, 149.0, 148.0, 149.0, 150.0, 150.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 94.0, 96.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 46.0, 43.0, 43.0, 44.0, 45.0, 43.0, 45.0, 45.0, 45.0], "value": 44.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [40.0, 40.0, 40.0, 39.0, 39.0, 39.0, 40.0, 39.0, 39.0, 39.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 75.0, 74.0, 74.0, 71.0, 70.0, 70.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 118.0, 111.0, 105.0, 106.0, 109.0, 112.0, 106.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 155.0, 155.0, 158.0, 148.0, 160.0, 162.0, 150.0, 152.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 59.0, 60.0, 60.0, 59.0, 60.0, 62.0, 57.0, 61.0], "value": 60.4, "unit": "score"}]}]} 18:20:18 INFO - Return code: 0 18:20:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:20:18 INFO - # TBPL SUCCESS # 18:20:18 INFO - Running post-action listener: _package_coverage_data 18:20:18 INFO - Running post-action listener: _resource_record_post_action 18:20:18 INFO - [mozharness: 2017-09-14 01:20:18.859505Z] Finished run-tests step (success) 18:20:18 INFO - Running post-run listener: _resource_record_post_run 18:20:18 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 270336; Write bytes: 339816448; Read time: 80; Write time: 245620 18:20:18 INFO - TinderboxPrint: CPU usage
13.1% 18:20:18 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 80 18:20:18 INFO - TinderboxPrint: I/O write bytes / time
339,816,448 / 245,620 18:20:18 INFO - TinderboxPrint: CPU idle
8,220.5 (86.9%) 18:20:18 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 18:20:18 INFO - TinderboxPrint: Swap in / out
0 / 0 18:20:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13205504; Read time: 0; Write time: 1440 18:20:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:20:18 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 266240; Write bytes: 326172672; Read time: 64; Write time: 244116 18:20:19 INFO - Running post-run listener: _upload_blobber_files 18:20:19 INFO - Blob upload gear active. 18:20:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:20:19 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 18:20:19 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'] 18:20:19 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 18:20:19 INFO - (blobuploader) - INFO - Open directory for files ... 18:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:20:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:20 INFO - (blobuploader) - INFO - Done attempting. 18:20:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:20:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:20:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:28 INFO - (blobuploader) - INFO - Done attempting. 18:20:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:20:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:29 INFO - (blobuploader) - INFO - Done attempting. 18:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:20:30 INFO - (blobuploader) - INFO - Done attempting. 18:20:30 INFO - (blobuploader) - INFO - Iteration through files over. 18:20:30 INFO - Return code: 0 18:20:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:20:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:20:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fac71511d7283190c04c037c1015771bad903e59d643447e0a678580389c206c34053c73ed57fa9c5aac8f9ba4b9db7a2639380f43356eaa35aac0aad116e7b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3b66a04fba8349d6f7227a62ac00e19ea60fcd4d884175f56c1b00cdbd923a4b0e83413e2a910638281896867f3f0a09fa57d6e1bbd9276423a6ab169e865eb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b04f01f7f91b89898d8681221ac08eb1f72ec505cdabe207b3684854a42e39ce3dcaa303367f2801452dcfc41826cbbcb51a9862d2e51f11b6580356c23da2a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc8728475d19bcf3b3897664a53b9ebe36370625573ade37a1f7e6d1cf3a3edbe56d8a13beb823936579d54fc94ed09e1079161f0ea7666cd17f10d4a96245c"} 18:20:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:20:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:20:30 INFO - Contents: 18:20:30 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fac71511d7283190c04c037c1015771bad903e59d643447e0a678580389c206c34053c73ed57fa9c5aac8f9ba4b9db7a2639380f43356eaa35aac0aad116e7b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3b66a04fba8349d6f7227a62ac00e19ea60fcd4d884175f56c1b00cdbd923a4b0e83413e2a910638281896867f3f0a09fa57d6e1bbd9276423a6ab169e865eb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b04f01f7f91b89898d8681221ac08eb1f72ec505cdabe207b3684854a42e39ce3dcaa303367f2801452dcfc41826cbbcb51a9862d2e51f11b6580356c23da2a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc8728475d19bcf3b3897664a53b9ebe36370625573ade37a1f7e6d1cf3a3edbe56d8a13beb823936579d54fc94ed09e1079161f0ea7666cd17f10d4a96245c"} 18:20:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:20:30 INFO - Copying logs to upload dir... 18:20:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:20:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.784389 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-13 18:20:30.359786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 18:20:30.363820) ========= 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=32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730 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/2fac71511d7283190c04c037c1015771bad903e59d643447e0a678580389c206c34053c73ed57fa9c5aac8f9ba4b9db7a2639380f43356eaa35aac0aad116e7b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3b66a04fba8349d6f7227a62ac00e19ea60fcd4d884175f56c1b00cdbd923a4b0e83413e2a910638281896867f3f0a09fa57d6e1bbd9276423a6ab169e865eb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b04f01f7f91b89898d8681221ac08eb1f72ec505cdabe207b3684854a42e39ce3dcaa303367f2801452dcfc41826cbbcb51a9862d2e51f11b6580356c23da2a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc8728475d19bcf3b3897664a53b9ebe36370625573ade37a1f7e6d1cf3a3edbe56d8a13beb823936579d54fc94ed09e1079161f0ea7666cd17f10d4a96245c"} build_url:https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/POjuiEnsQDKLgDbAo4kKuw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fac71511d7283190c04c037c1015771bad903e59d643447e0a678580389c206c34053c73ed57fa9c5aac8f9ba4b9db7a2639380f43356eaa35aac0aad116e7b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3b66a04fba8349d6f7227a62ac00e19ea60fcd4d884175f56c1b00cdbd923a4b0e83413e2a910638281896867f3f0a09fa57d6e1bbd9276423a6ab169e865eb", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b04f01f7f91b89898d8681221ac08eb1f72ec505cdabe207b3684854a42e39ce3dcaa303367f2801452dcfc41826cbbcb51a9862d2e51f11b6580356c23da2a", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bc8728475d19bcf3b3897664a53b9ebe36370625573ade37a1f7e6d1cf3a3edbe56d8a13beb823936579d54fc94ed09e1079161f0ea7666cd17f10d4a96245c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-13 18:20:30.394362) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 18:20:30.394823) ========= 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=32c5991c409366f7fec8a718000001d2-1505350791.659854-221667730 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-13 18:20:30.479506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 18:20:30.479901) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-13 18:20:30.480318) ========= ========= Total master_lag: 0.32 =========