builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1500946795.31 results: success (0) revision: f6528783c52507e29d5be409cc8fbf9a394a5ac8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.310410) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.310795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.311080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.326726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.326983) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-24 18:39:55-- 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% 222M=0s 2017-07-24 18:39:56 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.438039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.438354) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014405 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:55.489288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 18:39:55.489766) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6528783c52507e29d5be409cc8fbf9a394a5ac8 --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 f6528783c52507e29d5be409cc8fbf9a394a5ac8 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-24 18:39:56,141 truncating revision to first 12 chars 2017-07-24 18:39:56,141 Setting DEBUG logging. 2017-07-24 18:39:56,141 attempt 1/10 2017-07-24 18:39:56,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6528783c525?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-24 18:39:57,597 unpacking tar archive at: mozilla-central-f6528783c525/testing/mozharness/ program finished with exit code 0 elapsedTime=1.764697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-24 18:39:57.269887) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:57.270167) ========= script_repo_revision: f6528783c52507e29d5be409cc8fbf9a394a5ac8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:57.270548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:57.271089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-24 18:39:57.286279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-24 18:39:57.286547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:58 INFO - MultiFileLogger online at 20170724 18:39:58 in /builds/slave/test 18:39:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:39:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:58 INFO - {'append_to_log': False, 18:39:58 INFO - 'base_work_dir': '/builds/slave/test', 18:39:58 INFO - 'blob_upload_branch': 'Firefox', 18:39:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:58 INFO - 'branch': 'Firefox', 18:39:58 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:58 INFO - 'code_coverage': False, 18:39:58 INFO - 'config_files': ('talos/linux_config.py',), 18:39:58 INFO - 'default_actions': ('clobber', 18:39:58 INFO - 'read-buildbot-config', 18:39:58 INFO - 'download-and-extract', 18:39:58 INFO - 'populate-webroot', 18:39:58 INFO - 'create-virtualenv', 18:39:58 INFO - 'install', 18:39:58 INFO - 'setup-mitmproxy', 18:39:58 INFO - 'run-tests'), 18:39:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:58 INFO - 'disable_ccov_upload': False, 18:39:58 INFO - 'download_minidump_stackwalk': True, 18:39:58 INFO - 'download_symbols': 'ondemand', 18:39:58 INFO - 'enable_stylo': False, 18:39:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:58 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:58 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:58 INFO - 'gecko_profile': False, 18:39:58 INFO - 'gecko_profile_interval': 0, 18:39:58 INFO - 'installer_path': 'installer.exe', 18:39:58 INFO - 'log_level': 'info', 18:39:58 INFO - 'log_name': 'talos', 18:39:58 INFO - 'log_to_console': True, 18:39:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:58 INFO - 'opt_config_files': (), 18:39:58 INFO - 'pip_index': False, 18:39:58 INFO - 'suite': 'dromaeojs-e10s', 18:39:58 INFO - 'system_bits': '32', 18:39:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:58 INFO - 'title': 'talos-linux64-ix-041', 18:39:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:58 INFO - 'use_talos_json': True, 18:39:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:58 INFO - 'work_dir': 'build'} 18:39:58 INFO - [mozharness: 2017-07-25 01:39:58.046223Z] Running clobber step. 18:39:58 INFO - Running pre-action listener: _resource_record_pre_action 18:39:58 INFO - Running main action method: clobber 18:39:58 INFO - rmtree: /builds/slave/test/build 18:39:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:59 INFO - Running post-action listener: _resource_record_post_action 18:39:59 INFO - [mozharness: 2017-07-25 01:39:59.624276Z] Finished clobber step (success) 18:39:59 INFO - [mozharness: 2017-07-25 01:39:59.624378Z] Running read-buildbot-config step. 18:39:59 INFO - Running pre-action listener: _resource_record_pre_action 18:39:59 INFO - Running main action method: read_buildbot_config 18:39:59 INFO - Using buildbot properties: 18:39:59 INFO - { 18:39:59 INFO - "project": "", 18:39:59 INFO - "product": "firefox", 18:39:59 INFO - "who": "kwierso@gmail.com", 18:39:59 INFO - "installer_path": "public/build/target.tar.bz2", 18:39:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:39:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:39:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:39:59 INFO - "stage_platform": "linux64-stylosequential", 18:39:59 INFO - "basedir": "/builds/slave/test", 18:39:59 INFO - "buildnumber": 144, 18:39:59 INFO - "platform": "ubuntu64_hw_styloseq", 18:39:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:39:59 INFO - "slavebuilddir": "test", 18:39:59 INFO - "taskId": "PlQTdZOtTSqFLq7r4bRd0Q", 18:39:59 INFO - "branch": "mozilla-central", 18:39:59 INFO - "script_repo_revision": "production", 18:39:59 INFO - "revision": "f6528783c52507e29d5be409cc8fbf9a394a5ac8", 18:39:59 INFO - "slavename": "talos-linux64-ix-041", 18:39:59 INFO - "repo_path": "mozilla-central" 18:39:59 INFO - } 18:39:59 INFO - Finding installer, test and symbols from parent task. 18:39:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PlQTdZOtTSqFLq7r4bRd0Q'}, attempt #1 18:40:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PlQTdZOtTSqFLq7r4bRd0Q'}, attempt #1 18:40:00 INFO - Task dependencies: Dmp9ImL6RGu0AuUgN83OtA 18:40:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA'}, attempt #1 18:40:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/test_packages.json 18:40:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip 18:40:00 INFO - Running post-action listener: _resource_record_post_action 18:40:00 INFO - [mozharness: 2017-07-25 01:40:00.966961Z] Finished read-buildbot-config step (success) 18:40:00 INFO - [mozharness: 2017-07-25 01:40:00.967269Z] Running download-and-extract step. 18:40:00 INFO - Running pre-action listener: _resource_record_pre_action 18:40:00 INFO - Running main action method: download_and_extract 18:40:00 INFO - mkdir: /builds/slave/test/build/tests 18:40:01 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:40:01 INFO - trying https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.test_packages.json 18:40:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:40:01 INFO - Downloaded 989 bytes. 18:40:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:40:01 INFO - Using the following test package requirements: 18:40:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:40:01 INFO - u'common': [u'target.common.tests.zip'], 18:40:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:40:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:40:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:40:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:40:01 INFO - u'mozbase': [u'target.common.tests.zip'], 18:40:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:40:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:40:01 INFO - u'web-platform': [u'target.common.tests.zip', 18:40:01 INFO - u'target.web-platform.tests.tar.gz'], 18:40:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:40:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:40:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip 18:40:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:40:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip into memory 18:40:02 INFO - Content-Length response header: 72765760 18:40:02 INFO - Bytes received: 72765760 18:40:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:40:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip 18:40:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:40:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.common.tests.zip into memory 18:40:15 INFO - Content-Length response header: 72765760 18:40:15 INFO - Bytes received: 72765760 18:40:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.talos.tests.zip 18:40:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:40:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.talos.tests.zip into memory 18:40:29 INFO - Content-Length response header: 14498976 18:40:29 INFO - Bytes received: 14498976 18:40: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:40:29 INFO - trying https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:40:30 INFO - Downloaded 62021248 bytes. 18:40:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:30 INFO - mkdir: /builds/slave/test/properties 18:40:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:30 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:30 INFO - Contents: 18:40:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 18:40:30 INFO - Running post-action listener: _resource_record_post_action 18:40:30 INFO - Running post-action listener: set_extra_try_arguments 18:40:30 INFO - [mozharness: 2017-07-25 01:40:30.549145Z] Finished download-and-extract step (success) 18:40:30 INFO - [mozharness: 2017-07-25 01:40:30.549251Z] Running populate-webroot step. 18:40:30 INFO - Running pre-action listener: _resource_record_pre_action 18:40:30 INFO - Running main action method: populate_webroot 18:40:30 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:40:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:40:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:40:30 INFO - 'tests': ['damp', 'tps']}, 18:40:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:40:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:40:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:40:30 INFO - 'other-e10s': {'tests': ['a11yr', 18:40:30 INFO - 'ts_paint', 18:40:30 INFO - 'tpaint', 18:40:30 INFO - 'sessionrestore', 18:40:30 INFO - 'sessionrestore_many_windows', 18:40:30 INFO - 'sessionrestore_no_auto_restore', 18:40:30 INFO - 'tabpaint']}, 18:40:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:40:30 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:40:30 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:30 INFO - 'talos_options': ['--mitmproxy', 18:40:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:30 INFO - '--firstNonBlankPaint'], 18:40:30 INFO - 'tests': ['quantum_pageload_google', 18:40:30 INFO - 'quantum_pageload_youtube', 18:40:30 INFO - 'quantum_pageload_amazon', 18:40:30 INFO - 'quantum_pageload_facebook']}, 18:40:30 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:30 INFO - 'talos_options': ['--stylo', 18:40:30 INFO - '--mitmproxy', 18:40:30 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:30 INFO - '--firstNonBlankPaint'], 18:40:30 INFO - 'tests': ['quantum_pageload_google', 18:40:30 INFO - 'quantum_pageload_youtube', 18:40:30 INFO - 'quantum_pageload_amazon', 18:40:30 INFO - 'quantum_pageload_facebook']}, 18:40:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:40:30 INFO - 'tsvgr_opacity', 18:40:30 INFO - 'tart', 18:40:30 INFO - 'tscrollx', 18:40:30 INFO - 'cart', 18:40:30 INFO - 'tsvg_static']}, 18:40:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:40:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:40:30 INFO - 'talos_options': ['--xperf_path', 18:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:30 INFO - 'tests': ['tp5n']}}} 18:40:30 INFO - Running post-action listener: _resource_record_post_action 18:40:30 INFO - [mozharness: 2017-07-25 01:40:30.556564Z] Finished populate-webroot step (success) 18:40:30 INFO - [mozharness: 2017-07-25 01:40:30.556655Z] Running create-virtualenv step. 18:40:30 INFO - Running pre-action listener: _resource_record_pre_action 18:40:30 INFO - Running main action method: create_virtualenv 18:40:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:40:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:40:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:40:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:40:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:30 INFO - Using real prefix '/usr' 18:40:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:40:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:33 INFO - Installing pip.................done. 18:40:33 INFO - Return code: 0 18:40:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:40:33 INFO - Reading from file tmpfile_stdout 18:40:33 INFO - Output received: 18:40:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:40:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:33 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:33 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:40:33 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:40:33 INFO - Using env: {'DISPLAY': ':0', 18:40:33 INFO - 'HOME': '/home/cltbld', 18:40:33 INFO - 'LANG': 'en_US.UTF-8', 18:40:33 INFO - 'LANGUAGE': 'en_US:en', 18:40:33 INFO - 'LOGNAME': 'cltbld', 18:40:33 INFO - 'MAIL': '/var/mail/cltbld', 18:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:33 INFO - 'MOZ_NO_REMOTE': '1', 18:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:33 INFO - 'NO_EM_RESTART': '1', 18:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:33 INFO - 'PWD': '/builds/slave/test', 18:40:33 INFO - 'SHELL': '/bin/bash', 18:40:33 INFO - 'SHLVL': '1', 18:40:33 INFO - 'TERM': 'linux', 18:40:33 INFO - 'TMOUT': '86400', 18:40:33 INFO - 'USER': 'cltbld', 18:40:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:33 INFO - '_': '/tools/buildbot/bin/python'} 18:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:40:33 INFO - Cleaning up... 18:40:33 INFO - Return code: 0 18:40:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:33 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:33 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:40:33 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:40:33 INFO - Using env: {'DISPLAY': ':0', 18:40:33 INFO - 'HOME': '/home/cltbld', 18:40:33 INFO - 'LANG': 'en_US.UTF-8', 18:40:33 INFO - 'LANGUAGE': 'en_US:en', 18:40:33 INFO - 'LOGNAME': 'cltbld', 18:40:33 INFO - 'MAIL': '/var/mail/cltbld', 18:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:33 INFO - 'MOZ_NO_REMOTE': '1', 18:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:33 INFO - 'NO_EM_RESTART': '1', 18:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:33 INFO - 'PWD': '/builds/slave/test', 18:40:33 INFO - 'SHELL': '/bin/bash', 18:40:33 INFO - 'SHLVL': '1', 18:40:33 INFO - 'TERM': 'linux', 18:40:33 INFO - 'TMOUT': '86400', 18:40:33 INFO - 'USER': 'cltbld', 18:40:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:33 INFO - '_': '/tools/buildbot/bin/python'} 18:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:33 INFO - Downloading/unpacking psutil>=3.1.1 18:40:33 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:40:33 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:40:33 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:40:33 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:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:35 INFO - Installing collected packages: psutil 18:40:35 INFO - Running setup.py install for psutil 18:40:35 INFO - building 'psutil._psutil_linux' extension 18:40:35 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:40:35 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:40:35 INFO - building 'psutil._psutil_posix' extension 18:40:35 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:40:35 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:40:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:35 INFO - Successfully installed psutil 18:40:35 INFO - Cleaning up... 18:40:35 INFO - Return code: 0 18:40:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:40:35 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:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:35 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:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:35 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:35 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:40:35 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:40:35 INFO - Using env: {'DISPLAY': ':0', 18:40:35 INFO - 'HOME': '/home/cltbld', 18:40:35 INFO - 'LANG': 'en_US.UTF-8', 18:40:35 INFO - 'LANGUAGE': 'en_US:en', 18:40:35 INFO - 'LOGNAME': 'cltbld', 18:40:35 INFO - 'MAIL': '/var/mail/cltbld', 18:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:35 INFO - 'MOZ_NO_REMOTE': '1', 18:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:35 INFO - 'NO_EM_RESTART': '1', 18:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:35 INFO - 'PWD': '/builds/slave/test', 18:40:35 INFO - 'SHELL': '/bin/bash', 18:40:35 INFO - 'SHLVL': '1', 18:40:35 INFO - 'TERM': 'linux', 18:40:35 INFO - 'TMOUT': '86400', 18:40:35 INFO - 'USER': 'cltbld', 18:40:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:35 INFO - '_': '/tools/buildbot/bin/python'} 18:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:40:35 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:40:35 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:40:35 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:40:35 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:40:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:40:36 INFO - Installing collected packages: mozsystemmonitor 18:40:36 INFO - Running setup.py install for mozsystemmonitor 18:40:36 INFO - Successfully installed mozsystemmonitor 18:40:36 INFO - Cleaning up... 18:40:37 INFO - Return code: 0 18:40:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:40:37 INFO - Using env: {'DISPLAY': ':0', 18:40:37 INFO - 'HOME': '/home/cltbld', 18:40:37 INFO - 'LANG': 'en_US.UTF-8', 18:40:37 INFO - 'LANGUAGE': 'en_US:en', 18:40:37 INFO - 'LOGNAME': 'cltbld', 18:40:37 INFO - 'MAIL': '/var/mail/cltbld', 18:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:37 INFO - 'MOZ_NO_REMOTE': '1', 18:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:37 INFO - 'NO_EM_RESTART': '1', 18:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:37 INFO - 'PWD': '/builds/slave/test', 18:40:37 INFO - 'SHELL': '/bin/bash', 18:40:37 INFO - 'SHLVL': '1', 18:40:37 INFO - 'TERM': 'linux', 18:40:37 INFO - 'TMOUT': '86400', 18:40:37 INFO - 'USER': 'cltbld', 18:40:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:37 INFO - '_': '/tools/buildbot/bin/python'} 18:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:37 INFO - Downloading/unpacking jsonschema==2.5.1 18:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:40:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:40:38 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:40:38 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:40:38 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:40:38 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:40:38 INFO - Downloading functools32-3.2.3-2.tar.gz 18:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:40:38 INFO - warning: no files found matching '*.txt' 18:40:38 INFO - no previously-included directories found matching 'build' 18:40:38 INFO - no previously-included directories found matching 'dist' 18:40:38 INFO - no previously-included directories found matching '.git*' 18:40:38 INFO - Installing collected packages: jsonschema, functools32 18:40:38 INFO - Running setup.py install for functools32 18:40:38 INFO - warning: no files found matching '*.txt' 18:40:38 INFO - no previously-included directories found matching 'build' 18:40:38 INFO - no previously-included directories found matching 'dist' 18:40:38 INFO - no previously-included directories found matching '.git*' 18:40:38 INFO - Successfully installed jsonschema functools32 18:40:38 INFO - Cleaning up... 18:40:38 INFO - Return code: 0 18:40:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:40:38 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:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:38 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:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:38 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:38 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:40:38 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:40:38 INFO - Using env: {'DISPLAY': ':0', 18:40:38 INFO - 'HOME': '/home/cltbld', 18:40:38 INFO - 'LANG': 'en_US.UTF-8', 18:40:38 INFO - 'LANGUAGE': 'en_US:en', 18:40:38 INFO - 'LOGNAME': 'cltbld', 18:40:38 INFO - 'MAIL': '/var/mail/cltbld', 18:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:38 INFO - 'MOZ_NO_REMOTE': '1', 18:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:38 INFO - 'NO_EM_RESTART': '1', 18:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:38 INFO - 'PWD': '/builds/slave/test', 18:40:38 INFO - 'SHELL': '/bin/bash', 18:40:38 INFO - 'SHLVL': '1', 18:40:38 INFO - 'TERM': 'linux', 18:40:38 INFO - 'TMOUT': '86400', 18:40:38 INFO - 'USER': 'cltbld', 18:40:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:38 INFO - '_': '/tools/buildbot/bin/python'} 18:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:40:38 INFO - Cleaning up... 18:40:38 INFO - Return code: 0 18:40:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:38 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:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:38 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:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:38 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:38 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:40:38 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:40:38 INFO - Using env: {'DISPLAY': ':0', 18:40:38 INFO - 'HOME': '/home/cltbld', 18:40:38 INFO - 'LANG': 'en_US.UTF-8', 18:40:38 INFO - 'LANGUAGE': 'en_US:en', 18:40:38 INFO - 'LOGNAME': 'cltbld', 18:40:38 INFO - 'MAIL': '/var/mail/cltbld', 18:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:38 INFO - 'MOZ_NO_REMOTE': '1', 18:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:38 INFO - 'NO_EM_RESTART': '1', 18:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:38 INFO - 'PWD': '/builds/slave/test', 18:40:38 INFO - 'SHELL': '/bin/bash', 18:40:38 INFO - 'SHLVL': '1', 18:40:38 INFO - 'TERM': 'linux', 18:40:38 INFO - 'TMOUT': '86400', 18:40:38 INFO - 'USER': 'cltbld', 18:40:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:38 INFO - '_': '/tools/buildbot/bin/python'} 18:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:40 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:40 INFO - Downloading docopt-0.6.1.tar.gz 18:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:40 INFO - Running setup.py install for blobuploader 18:40:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:40 INFO - Running setup.py install for requests 18:40:41 INFO - Running setup.py install for docopt 18:40:41 INFO - Successfully installed blobuploader requests docopt 18:40:41 INFO - Cleaning up... 18:40:41 INFO - Return code: 0 18:40:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:41 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:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:41 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:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:41 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:41 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:40:41 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:40:41 INFO - Using env: {'DISPLAY': ':0', 18:40:41 INFO - 'HOME': '/home/cltbld', 18:40:41 INFO - 'LANG': 'en_US.UTF-8', 18:40:41 INFO - 'LANGUAGE': 'en_US:en', 18:40:41 INFO - 'LOGNAME': 'cltbld', 18:40:41 INFO - 'MAIL': '/var/mail/cltbld', 18:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:41 INFO - 'MOZ_NO_REMOTE': '1', 18:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:41 INFO - 'NO_EM_RESTART': '1', 18:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:41 INFO - 'PWD': '/builds/slave/test', 18:40:41 INFO - 'SHELL': '/bin/bash', 18:40:41 INFO - 'SHLVL': '1', 18:40:41 INFO - 'TERM': 'linux', 18:40:41 INFO - 'TMOUT': '86400', 18:40:41 INFO - 'USER': 'cltbld', 18:40:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:41 INFO - '_': '/tools/buildbot/bin/python'} 18:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:41 INFO - Running setup.py (path:/tmp/pip-WMNVyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:41 INFO - Running setup.py (path:/tmp/pip-72PZEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:41 INFO - Running setup.py (path:/tmp/pip-UjsCVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:41 INFO - Running setup.py (path:/tmp/pip-06EPOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:41 INFO - Running setup.py (path:/tmp/pip-741P1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:41 INFO - Running setup.py (path:/tmp/pip-gtaRF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:42 INFO - Running setup.py (path:/tmp/pip-l8uoIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:42 INFO - Running setup.py (path:/tmp/pip-gC5OLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:42 INFO - Running setup.py (path:/tmp/pip-LJRYXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:42 INFO - Running setup.py (path:/tmp/pip-2iKJWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:42 INFO - Running setup.py (path:/tmp/pip-83djmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:42 INFO - Running setup.py (path:/tmp/pip-JRu186-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:42 INFO - Running setup.py (path:/tmp/pip-nxX1db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:42 INFO - Running setup.py (path:/tmp/pip-qdVrCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:42 INFO - Running setup.py (path:/tmp/pip-qQkQCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:42 INFO - Running setup.py (path:/tmp/pip-y9uMl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:42 INFO - Running setup.py (path:/tmp/pip-fAjJzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:42 INFO - Running setup.py install for manifestparser 18:40:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:42 INFO - Running setup.py install for mozcrash 18:40:43 INFO - Running setup.py install for mozdebug 18:40:43 INFO - Running setup.py install for mozdevice 18:40:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Running setup.py install for mozfile 18:40:43 INFO - Running setup.py install for mozhttpd 18:40:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Running setup.py install for mozinfo 18:40:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Running setup.py install for mozInstall 18:40:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Running setup.py install for mozleak 18:40:43 INFO - Running setup.py install for mozlog 18:40:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Running setup.py install for moznetwork 18:40:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:43 INFO - Running setup.py install for mozprocess 18:40:44 INFO - Running setup.py install for mozprofile 18:40:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:44 INFO - Running setup.py install for mozrunner 18:40:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:44 INFO - Running setup.py install for mozscreenshot 18:40:44 INFO - Running setup.py install for moztest 18:40:44 INFO - Running setup.py install for mozversion 18:40:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:44 INFO - Cleaning up... 18:40:44 INFO - Return code: 0 18:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:44 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:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:44 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:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:44 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:44 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:40:44 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:40:44 INFO - Using env: {'DISPLAY': ':0', 18:40:44 INFO - 'HOME': '/home/cltbld', 18:40:44 INFO - 'LANG': 'en_US.UTF-8', 18:40:44 INFO - 'LANGUAGE': 'en_US:en', 18:40:44 INFO - 'LOGNAME': 'cltbld', 18:40:44 INFO - 'MAIL': '/var/mail/cltbld', 18:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:44 INFO - 'MOZ_NO_REMOTE': '1', 18:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:44 INFO - 'NO_EM_RESTART': '1', 18:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:44 INFO - 'PWD': '/builds/slave/test', 18:40:44 INFO - 'SHELL': '/bin/bash', 18:40:44 INFO - 'SHLVL': '1', 18:40:44 INFO - 'TERM': 'linux', 18:40:44 INFO - 'TMOUT': '86400', 18:40:44 INFO - 'USER': 'cltbld', 18:40:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:44 INFO - '_': '/tools/buildbot/bin/python'} 18:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:44 INFO - Running setup.py (path:/tmp/pip-RNjXjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:44 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:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:44 INFO - Running setup.py (path:/tmp/pip-APACfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:45 INFO - Running setup.py (path:/tmp/pip-1l5x0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:45 INFO - Running setup.py (path:/tmp/pip-MhaIsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:45 INFO - Running setup.py (path:/tmp/pip-BS1B6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:45 INFO - Running setup.py (path:/tmp/pip-NoZb0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:45 INFO - Running setup.py (path:/tmp/pip-30XC1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:45 INFO - Running setup.py (path:/tmp/pip-_NqlYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:45 INFO - Running setup.py (path:/tmp/pip-ScwXJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:45 INFO - Running setup.py (path:/tmp/pip-35FJh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:45 INFO - Running setup.py (path:/tmp/pip-ivUT1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:45 INFO - Running setup.py (path:/tmp/pip-yFYiZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:45 INFO - Running setup.py (path:/tmp/pip-dee59W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:45 INFO - Running setup.py (path:/tmp/pip-6jRnF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:45 INFO - Running setup.py (path:/tmp/pip-W6_BG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:45 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:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:45 INFO - Running setup.py (path:/tmp/pip-FlIpWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:46 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:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:46 INFO - Running setup.py (path:/tmp/pip-Z3aCPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:46 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:40:46 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:40:46 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:40:46 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:40:47 INFO - Downloading blessings-1.6.tar.gz 18:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:47 INFO - Installing collected packages: blessings 18:40:47 INFO - Running setup.py install for blessings 18:40:47 INFO - Successfully installed blessings 18:40:47 INFO - Cleaning up... 18:40:47 INFO - Return code: 0 18:40:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:47 INFO - Reading from file tmpfile_stdout 18:40:47 INFO - Current package versions: 18:40:47 INFO - argparse == 1.2.1 18:40:47 INFO - blessings == 1.6 18:40:47 INFO - blobuploader == 1.2.4 18:40:47 INFO - docopt == 0.6.1 18:40:47 INFO - functools32 == 3.2.3-2 18:40:47 INFO - jsonschema == 2.5.1 18:40:47 INFO - manifestparser == 1.1 18:40:47 INFO - mozInstall == 1.13 18:40:47 INFO - mozcrash == 1.0 18:40:47 INFO - mozdebug == 0.1 18:40:47 INFO - mozdevice == 0.51 18:40:47 INFO - mozfile == 1.2 18:40:47 INFO - mozhttpd == 0.7 18:40:47 INFO - mozinfo == 0.10 18:40:47 INFO - mozleak == 0.1 18:40:47 INFO - mozlog == 3.5 18:40:47 INFO - moznetwork == 0.27 18:40:47 INFO - mozprocess == 0.25 18:40:47 INFO - mozprofile == 0.28 18:40:47 INFO - mozrunner == 6.13 18:40:47 INFO - mozscreenshot == 0.1 18:40:47 INFO - mozsystemmonitor == 0.3 18:40:47 INFO - moztest == 0.8 18:40:47 INFO - mozversion == 1.4 18:40:47 INFO - psutil == 3.1.1 18:40:47 INFO - requests == 1.2.3 18:40:47 INFO - wsgiref == 0.1.2 18:40:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:47 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 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:47 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:40:47 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:40:47 INFO - Using env: {'DISPLAY': ':0', 18:40:47 INFO - 'HOME': '/home/cltbld', 18:40:47 INFO - 'LANG': 'en_US.UTF-8', 18:40:47 INFO - 'LANGUAGE': 'en_US:en', 18:40:47 INFO - 'LOGNAME': 'cltbld', 18:40:47 INFO - 'MAIL': '/var/mail/cltbld', 18:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:47 INFO - 'MOZ_NO_REMOTE': '1', 18:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:47 INFO - 'NO_EM_RESTART': '1', 18:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:47 INFO - 'PWD': '/builds/slave/test', 18:40:47 INFO - 'SHELL': '/bin/bash', 18:40:47 INFO - 'SHLVL': '1', 18:40:47 INFO - 'TERM': 'linux', 18:40:47 INFO - 'TMOUT': '86400', 18:40:47 INFO - 'USER': 'cltbld', 18:40:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:47 INFO - '_': '/tools/buildbot/bin/python'} 18:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 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:40:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:47 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:40:47 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:40:47 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:40:47 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:40:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:40:49 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:40:49 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:40:49 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:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:49 INFO - Installing collected packages: marionette-driver, simplejson 18:40:49 INFO - Running setup.py install for marionette-driver 18:40:49 INFO - Running setup.py install for simplejson 18:40:49 INFO - building 'simplejson._speedups' extension 18:40:49 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:40:50 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:40:50 INFO - Successfully installed marionette-driver simplejson 18:40:50 INFO - Cleaning up... 18:40:50 INFO - Return code: 0 18:40:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:40: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:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40: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:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d1ad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', '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:40:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:40:50 INFO - Using env: {'DISPLAY': ':0', 18:40:50 INFO - 'HOME': '/home/cltbld', 18:40:50 INFO - 'LANG': 'en_US.UTF-8', 18:40:50 INFO - 'LANGUAGE': 'en_US:en', 18:40:50 INFO - 'LOGNAME': 'cltbld', 18:40:50 INFO - 'MAIL': '/var/mail/cltbld', 18:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:50 INFO - 'MOZ_NO_REMOTE': '1', 18:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:50 INFO - 'NO_EM_RESTART': '1', 18:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:50 INFO - 'PWD': '/builds/slave/test', 18:40:50 INFO - 'SHELL': '/bin/bash', 18:40:50 INFO - 'SHLVL': '1', 18:40:50 INFO - 'TERM': 'linux', 18:40:50 INFO - 'TMOUT': '86400', 18:40:50 INFO - 'USER': 'cltbld', 18:40:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:50 INFO - '_': '/tools/buildbot/bin/python'} 18:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:40:50 INFO - Cleaning up... 18:40:50 INFO - Return code: 0 18:40:50 INFO - Running post-action listener: _resource_record_post_action 18:40:50 INFO - Running post-action listener: _start_resource_monitoring 18:40:50 INFO - Starting resource monitoring. 18:40:50 INFO - [mozharness: 2017-07-25 01:40:50.694213Z] Finished create-virtualenv step (success) 18:40:50 INFO - [mozharness: 2017-07-25 01:40:50.695177Z] Running install step. 18:40:50 INFO - Running pre-action listener: _resource_record_pre_action 18:40:50 INFO - Running main action method: install 18:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:50 INFO - Reading from file tmpfile_stdout 18:40:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:40:51 INFO - Reading from file tmpfile_stdout 18:40:51 INFO - Output received: 18:40:51 INFO - Usage: mozinstall [options] installer 18:40:51 INFO - Options: 18:40:51 INFO - -h, --help show this help message and exit 18:40:51 INFO - -d DEST, --destination=DEST 18:40:51 INFO - Directory to install application into. [default: 18:40:51 INFO - "/builds/slave/test"] 18:40:51 INFO - --app=APP Application being installed. [default: firefox] 18:40:51 INFO - mkdir: /builds/slave/test/build/application 18:40:51 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:40:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:41:09 INFO - Reading from file tmpfile_stdout 18:41:09 INFO - Output received: 18:41:09 INFO - /builds/slave/test/build/application/firefox/firefox 18:41:09 INFO - Running post-action listener: _resource_record_post_action 18:41:09 INFO - [mozharness: 2017-07-25 01:41:09.029075Z] Finished install step (success) 18:41:09 INFO - [mozharness: 2017-07-25 01:41:09.029223Z] Running setup-mitmproxy step. 18:41:09 INFO - Running pre-action listener: _resource_record_pre_action 18:41:09 INFO - Running main action method: setup_mitmproxy 18:41:09 INFO - Skipping: mitmproxy is not required 18:41:09 INFO - Running post-action listener: _resource_record_post_action 18:41:09 INFO - [mozharness: 2017-07-25 01:41:09.030393Z] Finished setup-mitmproxy step (success) 18:41:09 INFO - [mozharness: 2017-07-25 01:41:09.030616Z] Running run-tests step. 18:41:09 INFO - Running pre-action listener: _resource_record_pre_action 18:41:09 INFO - Running pre-action listener: _set_gcov_prefix 18:41:09 INFO - Running main action method: run_tests 18:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:41:09 INFO - Python 2.7.3 18:41:09 INFO - Return code: 0 18:41:09 INFO - grabbing minidump binary from tooltool 18:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2d17eb0>, '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 0x2d18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d19240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:41:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:41:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:41:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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:41:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:09 INFO - Return code: 0 18:41:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:41:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:41:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:41:09 INFO - ENV: RUST_BACKTRACE is now 1 18:41:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:41:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:41:09 INFO - Using env: {'DISPLAY': ':0', 18:41:09 INFO - 'HOME': '/home/cltbld', 18:41:09 INFO - 'LANG': 'en_US.UTF-8', 18:41:09 INFO - 'LANGUAGE': 'en_US:en', 18:41:09 INFO - 'LOGNAME': 'cltbld', 18:41:09 INFO - 'MAIL': '/var/mail/cltbld', 18:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:09 INFO - 'MOZ_NO_REMOTE': '1', 18:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:09 INFO - 'NO_EM_RESTART': '1', 18:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:09 INFO - 'PWD': '/builds/slave/test', 18:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:41:09 INFO - 'RUST_BACKTRACE': '1', 18:41:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:41:09 INFO - 'SHELL': '/bin/bash', 18:41:09 INFO - 'SHLVL': '1', 18:41:09 INFO - 'STYLO_FORCE_ENABLED': '1', 18:41:09 INFO - 'TERM': 'linux', 18:41:09 INFO - 'TMOUT': '86400', 18:41:09 INFO - 'USER': 'cltbld', 18:41:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358', 18:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:09 INFO - '_': '/tools/buildbot/bin/python'} 18:41:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:41:09 INFO - mozversion application_buildid: 20170725005803 18:41:09 INFO - mozversion application_changeset: f6528783c52507e29d5be409cc8fbf9a394a5ac8 18:41:09 INFO - mozversion application_display_name: Nightly 18:41:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:09 INFO - mozversion application_name: Firefox 18:41:09 INFO - mozversion application_remotingname: firefox 18:41:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:41:09 INFO - mozversion application_vendor: Mozilla 18:41:09 INFO - mozversion application_version: 56.0a1 18:41:09 INFO - mozversion platform_buildid: 20170725005803 18:41:09 INFO - mozversion platform_changeset: f6528783c52507e29d5be409cc8fbf9a394a5ac8 18:41:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:41:09 INFO - mozversion platform_version: 56.0a1 18:41:09 INFO - using testdate: 1500946869 18:41:09 INFO - actual date: 1500946869 18:41:09 INFO - starting webserver on 'localhost:40143' 18:41:09 INFO - SUITE-START | Running 2 tests 18:41:09 INFO - TEST-START | dromaeo_css 18:41:09 INFO - Initialising browser for dromaeo_css test... 18:41:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html -profile /tmp/tmpfku1df/profile 18:41:09 INFO - TEST-INFO | started process 25234 (/builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html) 18:41:15 INFO - TEST-INFO | 25234: exit 0 18:41:15 INFO - Browser initialized. 18:41:15 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:15 INFO - TEST-INFO | started process 25462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfku1df/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:27 INFO - PID 25462 | RSS: Main: 179027968 18:41:27 INFO - PID 25462 | 18:44:26 INFO - PID 25462 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40143/tests/dromaeo/cssquery-ext.html) 18:44:28 INFO - PID 25462 | RSS: Main: 180842496 18:44:28 INFO - PID 25462 | 18:47:29 INFO - PID 25462 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-ext.html (next: http://localhost:40143/tests/dromaeo/cssquery-jquery.html) 18:47:30 INFO - PID 25462 | RSS: Main: 178323456 18:47:30 INFO - PID 25462 | 18:50:32 INFO - PID 25462 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40143/tests/dromaeo/cssquery-mootools.html) 18:50:33 INFO - PID 25462 | RSS: Main: 180310016 18:50:33 INFO - PID 25462 | 18:53:34 INFO - PID 25462 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40143/tests/dromaeo/cssquery-prototype.html) 18:53:35 INFO - PID 25462 | RSS: Main: 178630656 18:53:35 INFO - PID 25462 | 18:56:39 INFO - PID 25462 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40143/tests/dromaeo/cssquery-yui.html) 18:56:39 INFO - PID 25462 | RSS: Main: 180494336 18:56:39 INFO - PID 25462 | 18:59:41 INFO - PID 25462 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-yui.html (next: http://localhost:40143/tests/dromaeo/cssquery-dojo.html) 18:59:42 INFO - PID 25462 | RSS: Main: 183287808 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | __start_tp_report 18:59:42 INFO - PID 25462 | _x_x_mozilla_page_load 18:59:42 INFO - PID 25462 | _x_x_mozilla_page_load_details 18:59:42 INFO - PID 25462 | |i|pagename|runs| 18:59:42 INFO - PID 25462 | |0;dojo.html;3128.0459459864746;3133.655297917229;3179.491281394976;3181.5863937688096;3233.7898036627616;6061.727222274997;6187.226596675416;6254.874902501947;6284.654344011077;6306.842328941773;6171.598846075013;6210.503159747221;6212.5961812482155;6218.657973811439;6270.216222972129;5680;5713.14302854572;5715.342735585419;5725.255716756816;5738.3974682658345;5786.479216870481;5797.594168408213;5808.622439541437;5824.708764561755;5843.328017278003;5671.602987790856;5729.684867332295;5731.254936858223;5734.541236701054;5773.1051686988585;5495.862603434906;5609.074502707049;5632.662040277555;5711.62874413166;5758.740856661419;5627.212190293362;5662.094064949588;5707.800226992035;5739.483446489836;5748;6050.062240352752;6052.576319657625;6094.786682466092;6133.325334213233;6154.1999540059505;6626.204855417381;6643.60138391698;6694.631795251259;6714.5971241725165;6717.227518835348;6669.066330713704;6687.732490700366;6763.323667633246;6765.255821859591;6783.966080169617;6103.542234332443;6182.289036760785;6199.442050215503;6200.627962322275;6246.718897649616;6755.898661520081;6899.689513971884;6910.239873613898;6946.0622815920215;6947.89578156328;6492.415682588496;6516.967415162989;6582.539222254492;6613.834654133589;6620.503462240351;6634.933650663432;6643.534952553275;6647.368499992493;6730.394264516217;6763.898541521881;6477.676116194266;6600.966995164993;6621.304762999912;6680.565763225375;6763.458923286125;6610.86778264432;6689.063531105649;6705.362990515893;6712.597244165366;6722.092517510171;5310.097283461821;5312.123499622597;5328.094223981932;5382.973085134628;5402.054640437907;4494.73031618104;4554.749488778083;4558.954410455853;4566.223741963874;4656.4877863434995;5794.739236734357;5868.354481007086;5877.0302900021015;5878.088896221093;5888.293404791452;6669.666516674147;6676.098726671934;6761.3238676132;6774.8645027100165;6828.624425656637;5660.603757736919;5687.544996400278;5742.799002034993;5753.108268218432;5853.560982926298;5815.651060936358;5892.558058145571;5908.556858235649;5913.526917846648;5918.319393269743;6499.935000649933;6500.3174666659315;6561.835954101186;6588.439982601437;6607.801765947125;6651.7006734698025;6705.362990515893;6713.899291510729;6720.563163394364;6826.795196144124;6475.708593113227;6483.578567393104;6492.058651495412;6536.575122617015;6553.737850485927;6528.445082168069;6564.245111812203;6632.336766323329;6663.033860090163;6694.765683201259;6587.440067594308;6674.332566743286;6720.1263835703;6742.69657865407;6828.522003459909;6415.518836087219;6444.709988050456;6447.484201263981;6478.449331806661;6478.870422591616;6489.415952564292;6489.610623362613;6552.901706474502;6557.508186885907;6568.573042752206;6352.68236588178;6397.840053998687;6451.580647257913;6455.0962865199845;6470.320616335217;6472.967635161794;6549.574277671936;6550.344965503412;6621.834454138685;6630.734770609314;6230.06549017651;6310.400511951358;6325.620462772248;6376.585521941059;6381.521385895983 18:59:42 INFO - PID 25462 | |1;ext.html;830.5639539241897;863.9827203455931;875.8467268228059;879.2965627498;1163.4996951310943;31089.222769430748;31650.525242121388;31674.84162579187;42757;43290.567094329046;42694.14611707764;43045.35431968515;43235;43416;43453;7194.20863704992;7624.580648064354;7695.8076048098965;7728.497647652885;7761.8059548511455;7588.354989825843;7729.227077292282;7730.072391313022;7737.07155141381;7742.032245969254;7564;7607;7608.885866712004;7648.273414025659;7671.156172820985;7541.283578060075;7584.810379740496;7626.084869815602;7626.885596716053;7638.274363935418;7487.588182649952;7504.249575042507;7516.473846830724;7521.811954701122;7536.284053014955;38570.61429385698;38701.225975480615;38778.418323725164;38822.80588597067;38917.805410973044;3548.8048157351336;3589.94615080774;3590.1563132663805;3595.7123430125525;3599.4240921452442;31722.841385793155;31734.523982140287;31759.682403175902;31762.523562146587;31808;4892.266160075981;4990.8752281193265;4991.226359914219;5004.749762511896;5040.269160971675;186047;186264;187117;187509;187533;46965.29552056722;47101.528984709716;47184;47252.76373618178;47293.76353118212;50009.24986125211;50146;50185.498145018086;50192.49807501951;50206.49793502091;15978.920105399631;16347.427840025543;16399;16404.09777462227;16420.507384778477;11700;11792.823107653392;13552.390142443614;13566.864331356757;13723.725525489433;14388.928055359656;14518.128912265087;14610.415583376545;14780.704385912437;14808.777868331983;5824.6020954971345;5939.287285525765;5962.880742385215;5972;5979.19280897082;954.6706386296717;987.5506644476745;1000.0999100809184;1001.5993602559034;1005.7485628592851;21457.67813482799;22043.559128817335;22098.779012209994;22144.88927555352;22231.555368892532;1079.624825384158;1089.7548051688307;1099.6041425086962;1118.9160812939062;1122.9382383968796;11511.654650360502;11607.535698572132;11921.28472291648;15725.213739312989;16126.113063781604;241642;243862;244359;244412;244566;56207;56852.14721779177;56908.43091569031;56950.57623559361;56993.71503142541;1424.522784867081;1444.415011920174;1449.7607894697258;1456.8251809782682;1461.8099647045815;25621.487570248864;26953.730462695905;27038.72961270362;27068.45863082688;27496;52015.2197717027;52021.7398913003;52058;52348.47651523436;52486.21270680866;211320;211466;212221;212373;213096;37459.81270093632;37713.24573508569;37790.244195115396;38688.41967370435;38733;45778.31332529948;47357.52642473531;47733.76133119451;47834.521654783006;47866.760666196446;33386;34362.65637343695;34626.48060279148;34699.13252168716;34925.30149396947;31947.6805231954;33276.66723332736;34226.48660270048;34468;34943.65056349404;37228.62771372252;37478;37498.81250593839;37676.43485347667;37795.24409511849;30891.227719307197;32890.67109328876;33467;33524.66475335313;33641.327173456884;23951.401214969766;24023;24519.509609807348;24698.753012469646;24718.876405617855 18:59:42 INFO - PID 25462 | |2;jquery.html;550.6014722604584;552.3371953655612;569.2827037932204;582.3710392775799;584.1733946465752;21852;22824.20115295965;22824.31527054187;22837.08651653934;22851.885740571317;25042.49915001699;25860.353491162732;25910.611340829902;25954.48091038183;25966.610500842457;6500.707468163932;6654.600723956554;6656.101426307435;6666.933330666704;6680.031395447657;6021.096835474692;6490.675466226693;6524.7063882125185;6541.869162616745;6551.737930482775;6494.155759751226;6496.870062598745;6497.415232629062;6526.543141980063;6528;6470.4823614110755;6490.253620833618;6522.347765223463;6523.380278873499;6526.412622863965;6038.305594856603;6048.69756512177;6065.696715164224;6072.483838873701;6075.848103797396;29389.412211755644;29523.261918451997;30039.399212015855;30981.22546936322;31003.379932401225;1858.2009735813594;1897.6963685810342;1897.7153426985924;1898.6202759448026;1902.048975512244;19240.903795481074;19329;20034.79965200344;20058.598828023503;20211.696824547642;2323.697919270484;2365.47959448921;2368.017272831773;2373.964390534143;2392.6650268962358;133326.3333683335;140809;141057.58942410548;141251.29374353166;141440;14819.77770333446;14860.256987150598;15304.693906121815;15664.373425063097;15735.527934161993;23476.178333758235;23545.646815297783;23559.293221203392;23571.76428235696;23595.76404235936;9150.908490915006;9174.86237706435;9221.769455763526;9278.304127190488;9330.066993300616;8129.634166462523;8226.712065077694;8308.12764659714;8316.625751841182;8872.911270887209;8842.381033327605;9247.861282080774;9397.624095036259;9424;9557.139857412867;2563.2310306907852;2579.303588031221;2641.3924797296345;2662.108193755114;2774.3480282133683;964.4417084395983;974.2108891797667;982.8820541535061;1005.4218824176128;1010.075780660702;19327.710084348746;19551;19608.90195549013;19779;20434.591308173753;997.7056768253383;1028.228828378716;1039.0752230514847;1040.9011143941314;1050.6375300521308;10799;10948.507317170746;10993.670189894316;11158.944205278922;11247.762746097922;512884;520997;521893;523041;525524;110235;114423.42788286172;114750.42624786822;115244;116109;1241.7516496700696;1271.9809202861964;1295.1646188208554;1298.078364361314;1299.064673435125;16802.747958780383;17486.562835929202;17625.471235862944;17697.115144242995;18184.90907545454;52447;53275;53822;54296.18555721588;54406.72796635992;66092;67836.32163678498;68480.3151968474;69631.6518417425;70523.29476705167;14260;14572.198529081003;15151.015184013004;15231.619209519851;15292.61768455753;22965.65551516762;23829.761702382755;24152.396190095387;24180.153694620603;24239.878800605886;18759.718604220674;18760.718589220898;18830.811691882907;19044.71432928535;19083.713744293567;16743;16844.410445634836;17188.914055430145;17321.480355589352;17466.388676396775;18727.250909963448;19226;19420.8057919419;19492.220311187393;19510;14862.777058343918;15060.698786024437;15151.848481515044;15158.469453569513;15174.317155727798;16589.75115373246;17219.22513486921;17234.569135771708;17249.827501725325;17319 18:59:42 INFO - PID 25462 | |3;mootools.html;1326.2771789374792;1382.1361648969394;1391.3599744117705;1396.2320723602015;1400.334840950548;13081.476740930351;13113.7377252455;13819.723605527883;13866;13911.443542258323;14051.43794248229;14176.291185440738;14262.286885655727;14277.071990320648;14338.283085845718;2595.8961641534365;2649.4436168404563;2649.682038155424;2652.2308530526125;2662.986685066572;2543.351445381425;2691.3406215477235;2700.635414219075;2727.7681397081274;2735.9452810943767;2594.3254753764063;2599.6230546570737;2615.6338112664243;2622.8819703113404;2623.3966187776823;2587.987060064697;2627.487639910218;2630.1846427607406;2633;2636.4331668691134;2595.1046888823325;2605.231456720253;2616.3589920469417;2616.5290247755397;2617;13603.251821149834;13688.452461901512;13839;13858.65353366174;13862.237576933265;7323.670434830446;7495.812604684872;7532.736354227631;7814.1013783415065;7816.648250828726;4991.126552853236;5195.142801437758;5235.240890070956;5288.947110528884;5302.522772950453;1778.5998150416183;1780.5904641932298;1803.9007854567994;1843.3916807453643;1845.5386153461634;21276.148954041975;21516.139354425803;21576.24483143098;21584.460388490257;21612.135514579397;6220.253569571681;6295.244570651551;6327.082573026977;6412.070249813844;6426.068220108058;14993.700125997637;15033.173175475455;15075.396984120513;15080.773788393182;15103.773443398359;7098;7698.730544430918;7709.884351734729;7714.305712485903;7756.806079848049;6499;6834.453243740489;6849.349311815369;6991.580505169706;6994.195667498303;4935.605151587864;4992.475790041994;5022.171341728574;5126.871828204325;5147.6911385317;1484.4952716076587;1494.2603411311254;1502.6393665520197;1503.3688448034006;1523.0785374848058;882.5543100734088;895.7536677413633;900.3697411811758;916.5829547555846;923.132255679659;6697.598144111369;6807.931920680829;6896.896546551806;7033.929660703429;7064;652.5693042591867;713.9500234983606;736.9336759691654;741.0440531714029;752.2966026764992;4290.377895205178;4629.768511574475;4675.602573781199;4922.778474968635;4965.155923493015;17404.129793510274;17833.375831846082;18059.909700451677;18079.909600452178;18134.727979080326;17725.556861078578;18761.53096172579;18839;18846.43460696181;18914.716279255823;10008.14930730896;10145.137663298703;10153.441560714231;10156.644517442002;10239.59041638341;7348.889766653611;8181.877271840808;8259.587020648823;8295.751127465945;8385.077641459313;15264.771028434805;16015.839841601435;16161.515154545383;16304.103274320027;16591.25339359756;15440.150791706565;15947.44183953556;16213;16659.416920407726;16832.663346733243;10762.784744304914;10939.50772215268;10944.507497162806;10966.177536684621;10996.890031099907;12534.059945504307;12602.369881505705;12627.810582841448;12662.683432914251;12664.366781660696;10026.348287361297;10223.131033861908;10565.683029509128;10736;10795.892041079804;9698.6120555177;10211.438370889673;10238.385696858213;10351.689449316533;10619.15046796239;9292.070792920655;9335.766605834908;9396.342256042011;9401.623935042795;9422.57598408087;6572.375624315682;6910.239873613999;7020.087388639648;7079.504434689522;7148.892766608609;6977.895331570132;7005.894911576433;7020.543664661781;7026.929730702832;7138.143422789299 18:59:42 INFO - PID 25462 | |4;prototype.html;467.0775218942591;491.69760597232704;502.74611321282754;503.09191908604953;515.5102652480142;6084.269887613487;6107.38926107389;6196.442320191182;6199.582162956451;6262.185915830942;5916.792912248072;6052.001419765734;6088.48247898928;6099.756009759604;6104.938950610493;4878.34142390778;4886.242632391985;4887.193613053851;4902.0931127741305;4941.579965702902;4917.72952487613;4918.729469879156;4922.68002579833;4925.852224433254;4980.327655766461;4738.834140805073;4878.317035615017;4878.853634390974;4910.877228069291;4942.308076869242;4859.489753575876;4877.317175595419;4911.214205727067;4945.975270123644;4955.603551715854;4414.227510185705;4429.844955426577;4442.8667139985855;4448.421705178306;4453.688241823073;5997.760089596411;6015.27816661999;6032.125341825411;6065.5450841187085;6170.673305239395;5622;5649.209110724501;5655.519280861132;5704.372519022904;5715.428457154293;6408.23101227851;6423.96788016057;6442.936915408952;6465.709043093072;6482.967585162091;4784.330193772875;4893.657443978923;4898.412190537123;4898.461169271377;4906.043321552299;6903.37770623903;6931.643241297932;6932.168139823253;6934.791956241321;6938.236793952661;4934.851954441301;4990.775415106329;4993.925091123636;5010.549050585392;5025.3416372597685;5041.092603331363;5059.949400506021;5083.822066227738;5094.414142373675;5105.744712764347;5544.004158502936;5582.720863956867;5634.85912852182;5642.758593109592;5675.1487276907965;6445.838854028593;6499.675016249169;6509.2839787623325;6544.44372228366;6616.702248398834;1627.9267432965546;1659.9874076813135;1704.5994191365019;1723.4488959936157;1742.3553285284272;1126.707056165403;1201.6935681401187;1203.7472130852618;1210.903127749778;1231.815227715832;5638;5701.857453563694;5743.62666426681;5770.221020162308;5780.219670344533;6453.483721302378;6536.901946470807;6580.539362244693;6600.933990660032;6630;5653.378128405872;5655.745491452894;5681.375048744635;5691.573132015115;5765.8558536036935;3543.698785603201;3588.5334906462517;3589.425691889285;3619.1675914539805;3628.3650361186687;6465.64438955862;6520.282768895418;6530.2816690164045;6531.902021469682;6542.967285163544;6886.51794374389;6904.620245886424;6941.895871561931;6969.860602787916;6990.685419156151;6399.6800159992745;6403.743850245938;6428.8071357859335;6461.773837915651;6504.577202481823;6652.434543063894;6713.597184168965;6730.754810360099;6758.560693554903;6772.255051944184;6575.671216439255;6615.536912416084;6648.16897887764;6666.766663166766;6683.966580167068;6345;6420.518461115342;6446.9355306448215;6500.382463665944;6524.836879078061;4895.926561101515;4899.559039686445;4909.26361045846;4975.975120124376;4982.227754698028;6694.121527743117;6698.799036028927;6770;6773.864522709617;6822.692978815866;6308.905366419599;6396.232452105777;6447.580907241202;6476.805695829133;6582.473402127723;6379.840503987438;6459.386358295955;6461.029386037304;6471.644059576768;6532.9346706534225;5925.585209035326;6089;6167.938320616737;6238.376162383725;6271.463491444625;6501.317361676955;6517.3808488193545;6518.120053792867;6557.672116394257;6567.671616419065;6220.813375598739;6274.925286609619;6327.658766256514;6335.3981371769605;6337.017762246859 18:59:42 INFO - PID 25462 | |5;yui.html;823.5904787799391;840.4915026409026;851.3189448441245;907.7231444409455;932.6828878181419;16717.916410417947;17220;17236.224369903353;17316.82683173168;21899.124035038578;20035.59928801423;21032.579348413023;21043.894780526076;21167.259145929896;21190.25834095807;1026.7741096958694;1054.4411461925154;1056.0442799266636;1062.9681109566725;1063.1176123817252;1013.3583594576796;1047.4919663962971;1059.1950117910367;1059.629129804566;1062.4900047976976;1103.1671088328342;1105.082781291526;1106.1758989552795;1107.7839821234863;1111;1092.4919912240807;1102.509383324421;1103.6082190822224;1103.8675358956896;1112.7496313329516;802.4062193976474;809.3161278719473;809.5142914251461;811.853866304065;817.709713051864;17884.642307153914;18335.17491712863;18365.173567189508;18391.448256552325;19383.903080484648;20554.486137846525;20573.4856628584;20893;21107.15571377143;21193;15871.841281587152;15872.52382428529;16165.4342098026;16322.510324690278;16393.508194754177;3550.786952782841;3564.9643503565153;3570.9285814283567;3581.230035542371;3587.6412358763914;115057.42471287673;118284.40857795656;120119.17437750837;123452;123615;15603.609909752347;16719.91640041792;16734.916325418297;16737;16767.077810720282;30319;30380.392392152033;30544.236394090327;30592.388152236832;30653.84673076665;6839.794806155824;7188.388986936169;7235.674394652148;7310.59791711461;7333.413326933833;3889.53325600924;4008.0581063450068;4011.956891208307;4022.4770779799023;4026.859059932888;5017.272495488134;5122.692638441706;5185.662931909414;5193.662411943212;5224.268602395668;983.5819776594918;1002.1231422505308;1011.4083261292079;1011.4740335025746;1018.556927736437;564.5568228940263;614.5882258886556;620.4106099205773;635.6059243269202;664.2129077043719;10501.9474902625;11441.885581144248;11536.94231528837;12951.611451656465;13723.794143087862;692.9237783843773;694.7568351077083;695.9617221052789;698.7414656577099;706.8162277807704;5561.833145005657;5770.278715160605;6055.303640081447;6056.57603967718;6224.408681175281;100756.49621751845;101026.4948675252;102309;105301;105826;81338;88363.11636883678;88624.55687721648;89222;90468;71944.28055719481;73722.26277737261;77013.22986770172;78316.21683783203;79663.60168199122;11876.228045177037;12053.879461205626;12503.499860005499;12504.792109573706;12531.87468125307;35145;36628.63371366252;37660;38351.80824095861;39338.016549586486;46196.76901615471;46658.76670616625;46989.76505117589;47144.29283560818;48302;17769.200385982404;18173;18239.817601823812;18241.908790456495;18314.81685183131;18387.17257723379;19119.330823421114;19382.321618743277;19438.708419374005;19488.61022779565;17964.10179490994;18007.819921800616;18023.369182078564;18196.09019548991;18272.17775200146;18609.90695046516;18783;18861.15124819359;19010.049497525346;19010.95439750827;16911.238994245043;17013.23440445158;17065;17088.658226835643;17176.914115429343;12764.42560084817;13638.181709097486;13826.170429774245;13887;14177.787333189804;13077.934610326887;13359;13459.139959871962;14048;14314.642133946734 18:59:42 INFO - PID 25462 | __end_tp_report 18:59:42 INFO - PID 25462 | __start_cc_report 18:59:42 INFO - PID 25462 | _x_x_mozilla_cycle_collect,396 18:59:42 INFO - PID 25462 | __end_cc_report 18:59:42 INFO - PID 25462 | __startTimestamp1500947982088__endTimestamp 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | ------- Summary: start ------- 18:59:42 INFO - PID 25462 | Number of tests: 6 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | [#0] dojo.html Cycles:165 Average:6148.84 Median:6415.52 stddev:731.72 (11.4%) stddev-sans-first:694.53 18:59:42 INFO - PID 25462 | Values: 3128.0 3133.7 3179.5 3181.6 3233.8 6061.7 6187.2 6254.9 6284.7 6306.8 6171.6 6210.5 6212.6 6218.7 6270.2 5680.0 5713.1 5715.3 5725.3 5738.4 5786.5 5797.6 5808.6 5824.7 5843.3 5671.6 5729.7 5731.3 5734.5 5773.1 5495.9 5609.1 5632.7 5711.6 5758.7 5627.2 5662.1 5707.8 5739.5 5748.0 6050.1 6052.6 6094.8 6133.3 6154.2 6626.2 6643.6 6694.6 6714.6 6717.2 6669.1 6687.7 6763.3 6765.3 6784.0 6103.5 6182.3 6199.4 6200.6 6246.7 6755.9 6899.7 6910.2 6946.1 6947.9 6492.4 6517.0 6582.5 6613.8 6620.5 6634.9 6643.5 6647.4 6730.4 6763.9 6477.7 6601.0 6621.3 6680.6 6763.5 6610.9 6689.1 6705.4 6712.6 6722.1 5310.1 5312.1 5328.1 5383.0 5402.1 4494.7 4554.7 4559.0 4566.2 4656.5 5794.7 5868.4 5877.0 5878.1 5888.3 6669.7 6676.1 6761.3 6774.9 6828.6 5660.6 5687.5 5742.8 5753.1 5853.6 5815.7 5892.6 5908.6 5913.5 5918.3 6499.9 6500.3 6561.8 6588.4 6607.8 6651.7 6705.4 6713.9 6720.6 6826.8 6475.7 6483.6 6492.1 6536.6 6553.7 6528.4 6564.2 6632.3 6663.0 6694.8 6587.4 6674.3 6720.1 6742.7 6828.5 6415.5 6444.7 6447.5 6478.4 6478.9 6489.4 6489.6 6552.9 6557.5 6568.6 6352.7 6397.8 6451.6 6455.1 6470.3 6473.0 6549.6 6550.3 6621.8 6630.7 6230.1 6310.4 6325.6 6376.6 6381.5 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | [#1] ext.html Cycles:180 Average:39171.99 Median:3597.57 stddev:55932.09 (1554.7%) stddev-sans-first:56014.90 18:59:42 INFO - PID 25462 | Values: 830.6 864.0 875.8 879.3 1163.5 31089.2 31650.5 31674.8 42757.0 43290.6 42694.1 43045.4 43235.0 43416.0 43453.0 7194.2 7624.6 7695.8 7728.5 7761.8 7588.4 7729.2 7730.1 7737.1 7742.0 7564.0 7607.0 7608.9 7648.3 7671.2 7541.3 7584.8 7626.1 7626.9 7638.3 7487.6 7504.2 7516.5 7521.8 7536.3 38570.6 38701.2 38778.4 38822.8 38917.8 3548.8 3589.9 3590.2 3595.7 3599.4 31722.8 31734.5 31759.7 31762.5 31808.0 4892.3 4990.9 4991.2 5004.7 5040.3 186047.0 186264.0 187117.0 187509.0 187533.0 46965.3 47101.5 47184.0 47252.8 47293.8 50009.2 50146.0 50185.5 50192.5 50206.5 15978.9 16347.4 16399.0 16404.1 16420.5 11700.0 11792.8 13552.4 13566.9 13723.7 14388.9 14518.1 14610.4 14780.7 14808.8 5824.6 5939.3 5962.9 5972.0 5979.2 954.7 987.6 1000.1 1001.6 1005.7 21457.7 22043.6 22098.8 22144.9 22231.6 1079.6 1089.8 1099.6 1118.9 1122.9 11511.7 11607.5 11921.3 15725.2 16126.1 241642.0 243862.0 244359.0 244412.0 244566.0 56207.0 56852.1 56908.4 56950.6 56993.7 1424.5 1444.4 1449.8 1456.8 1461.8 25621.5 26953.7 27038.7 27068.5 27496.0 52015.2 52021.7 52058.0 52348.5 52486.2 211320.0 211466.0 212221.0 212373.0 213096.0 37459.8 37713.2 37790.2 38688.4 38733.0 45778.3 47357.5 47733.8 47834.5 47866.8 33386.0 34362.7 34626.5 34699.1 34925.3 31947.7 33276.7 34226.5 34468.0 34943.7 37228.6 37478.0 37498.8 37676.4 37795.2 30891.2 32890.7 33467.0 33524.7 33641.3 23951.4 24023.0 24519.5 24698.8 24718.9 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | [#2] jquery.html Cycles:180 Average:35508.93 Median:23565.53 stddev:87312.68 (370.5%) stddev-sans-first:87518.16 18:59:42 INFO - PID 25462 | Values: 550.6 552.3 569.3 582.4 584.2 21852.0 22824.2 22824.3 22837.1 22851.9 25042.5 25860.4 25910.6 25954.5 25966.6 6500.7 6654.6 6656.1 6666.9 6680.0 6021.1 6490.7 6524.7 6541.9 6551.7 6494.2 6496.9 6497.4 6526.5 6528.0 6470.5 6490.3 6522.3 6523.4 6526.4 6038.3 6048.7 6065.7 6072.5 6075.8 29389.4 29523.3 30039.4 30981.2 31003.4 1858.2 1897.7 1897.7 1898.6 1902.0 19240.9 19329.0 20034.8 20058.6 20211.7 2323.7 2365.5 2368.0 2374.0 2392.7 133326.3 140809.0 141057.6 141251.3 141440.0 14819.8 14860.3 15304.7 15664.4 15735.5 23476.2 23545.6 23559.3 23571.8 23595.8 9150.9 9174.9 9221.8 9278.3 9330.1 8129.6 8226.7 8308.1 8316.6 8872.9 8842.4 9247.9 9397.6 9424.0 9557.1 2563.2 2579.3 2641.4 2662.1 2774.3 964.4 974.2 982.9 1005.4 1010.1 19327.7 19551.0 19608.9 19779.0 20434.6 997.7 1028.2 1039.1 1040.9 1050.6 10799.0 10948.5 10993.7 11158.9 11247.8 512884.0 520997.0 521893.0 523041.0 525524.0 110235.0 114423.4 114750.4 115244.0 116109.0 1241.8 1272.0 1295.2 1298.1 1299.1 16802.7 17486.6 17625.5 17697.1 18184.9 52447.0 53275.0 53822.0 54296.2 54406.7 66092.0 67836.3 68480.3 69631.7 70523.3 14260.0 14572.2 15151.0 15231.6 15292.6 22965.7 23829.8 24152.4 24180.2 24239.9 18759.7 18760.7 18830.8 19044.7 19083.7 16743.0 16844.4 17188.9 17321.5 17466.4 18727.3 19226.0 19420.8 19492.2 19510.0 14862.8 15060.7 15151.8 15158.5 15174.3 16589.8 17219.2 17234.6 17249.8 17319.0 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | [#3] mootools.html Cycles:180 Average:8400.86 Median:2610.43 stddev:5615.16 (215.1%) stddev-sans-first:5605.74 18:59:42 INFO - PID 25462 | Values: 1326.3 1382.1 1391.4 1396.2 1400.3 13081.5 13113.7 13819.7 13866.0 13911.4 14051.4 14176.3 14262.3 14277.1 14338.3 2595.9 2649.4 2649.7 2652.2 2663.0 2543.4 2691.3 2700.6 2727.8 2735.9 2594.3 2599.6 2615.6 2622.9 2623.4 2588.0 2627.5 2630.2 2633.0 2636.4 2595.1 2605.2 2616.4 2616.5 2617.0 13603.3 13688.5 13839.0 13858.7 13862.2 7323.7 7495.8 7532.7 7814.1 7816.6 4991.1 5195.1 5235.2 5288.9 5302.5 1778.6 1780.6 1803.9 1843.4 1845.5 21276.1 21516.1 21576.2 21584.5 21612.1 6220.3 6295.2 6327.1 6412.1 6426.1 14993.7 15033.2 15075.4 15080.8 15103.8 7098.0 7698.7 7709.9 7714.3 7756.8 6499.0 6834.5 6849.3 6991.6 6994.2 4935.6 4992.5 5022.2 5126.9 5147.7 1484.5 1494.3 1502.6 1503.4 1523.1 882.6 895.8 900.4 916.6 923.1 6697.6 6807.9 6896.9 7033.9 7064.0 652.6 714.0 736.9 741.0 752.3 4290.4 4629.8 4675.6 4922.8 4965.2 17404.1 17833.4 18059.9 18079.9 18134.7 17725.6 18761.5 18839.0 18846.4 18914.7 10008.1 10145.1 10153.4 10156.6 10239.6 7348.9 8181.9 8259.6 8295.8 8385.1 15264.8 16015.8 16161.5 16304.1 16591.3 15440.2 15947.4 16213.0 16659.4 16832.7 10762.8 10939.5 10944.5 10966.2 10996.9 12534.1 12602.4 12627.8 12662.7 12664.4 10026.3 10223.1 10565.7 10736.0 10795.9 9698.6 10211.4 10238.4 10351.7 10619.2 9292.1 9335.8 9396.3 9401.6 9422.6 6572.4 6910.2 7020.1 7079.5 7148.9 6977.9 7005.9 7020.5 7026.9 7138.1 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | [#4] prototype.html Cycles:180 Average:5463.13 Median:6058.77 stddev:1540.20 (25.4%) stddev-sans-first:1498.17 18:59:42 INFO - PID 25462 | Values: 467.1 491.7 502.7 503.1 515.5 6084.3 6107.4 6196.4 6199.6 6262.2 5916.8 6052.0 6088.5 6099.8 6104.9 4878.3 4886.2 4887.2 4902.1 4941.6 4917.7 4918.7 4922.7 4925.9 4980.3 4738.8 4878.3 4878.9 4910.9 4942.3 4859.5 4877.3 4911.2 4946.0 4955.6 4414.2 4429.8 4442.9 4448.4 4453.7 5997.8 6015.3 6032.1 6065.5 6170.7 5622.0 5649.2 5655.5 5704.4 5715.4 6408.2 6424.0 6442.9 6465.7 6483.0 4784.3 4893.7 4898.4 4898.5 4906.0 6903.4 6931.6 6932.2 6934.8 6938.2 4934.9 4990.8 4993.9 5010.5 5025.3 5041.1 5059.9 5083.8 5094.4 5105.7 5544.0 5582.7 5634.9 5642.8 5675.1 6445.8 6499.7 6509.3 6544.4 6616.7 1627.9 1660.0 1704.6 1723.4 1742.4 1126.7 1201.7 1203.7 1210.9 1231.8 5638.0 5701.9 5743.6 5770.2 5780.2 6453.5 6536.9 6580.5 6600.9 6630.0 5653.4 5655.7 5681.4 5691.6 5765.9 3543.7 3588.5 3589.4 3619.2 3628.4 6465.6 6520.3 6530.3 6531.9 6543.0 6886.5 6904.6 6941.9 6969.9 6990.7 6399.7 6403.7 6428.8 6461.8 6504.6 6652.4 6713.6 6730.8 6758.6 6772.3 6575.7 6615.5 6648.2 6666.8 6684.0 6345.0 6420.5 6446.9 6500.4 6524.8 4895.9 4899.6 4909.3 4976.0 4982.2 6694.1 6698.8 6770.0 6773.9 6822.7 6308.9 6396.2 6447.6 6476.8 6582.5 6379.8 6459.4 6461.0 6471.6 6532.9 5925.6 6089.0 6167.9 6238.4 6271.5 6501.3 6517.4 6518.1 6557.7 6567.7 6220.8 6274.9 6327.7 6335.4 6337.0 18:59:42 INFO - PID 25462 | 18:59:42 INFO - PID 25462 | [#5] yui.html Cycles:180 Average:21941.64 Median:18935.60 stddev:29107.61 (153.7%) stddev-sans-first:29146.07 18:59:42 INFO - PID 25462 | Values: 823.6 840.5 851.3 907.7 932.7 16717.9 17220.0 17236.2 17316.8 21899.1 20035.6 21032.6 21043.9 21167.3 21190.3 1026.8 1054.4 1056.0 1063.0 1063.1 1013.4 1047.5 1059.2 1059.6 1062.5 1103.2 1105.1 1106.2 1107.8 1111.0 1092.5 1102.5 1103.6 1103.9 1112.7 802.4 809.3 809.5 811.9 817.7 17884.6 18335.2 18365.2 18391.4 19383.9 20554.5 20573.5 20893.0 21107.2 21193.0 15871.8 15872.5 16165.4 16322.5 16393.5 3550.8 3565.0 3570.9 3581.2 3587.6 115057.4 118284.4 120119.2 123452.0 123615.0 15603.6 16719.9 16734.9 16737.0 16767.1 30319.0 30380.4 30544.2 30592.4 30653.8 6839.8 7188.4 7235.7 7310.6 7333.4 3889.5 4008.1 4012.0 4022.5 4026.9 5017.3 5122.7 5185.7 5193.7 5224.3 983.6 1002.1 1011.4 1011.5 1018.6 564.6 614.6 620.4 635.6 664.2 10501.9 11441.9 11536.9 12951.6 13723.8 692.9 694.8 696.0 698.7 706.8 5561.8 5770.3 6055.3 6056.6 6224.4 100756.5 101026.5 102309.0 105301.0 105826.0 81338.0 88363.1 88624.6 89222.0 90468.0 71944.3 73722.3 77013.2 78316.2 79663.6 11876.2 12053.9 12503.5 12504.8 12531.9 35145.0 36628.6 37660.0 38351.8 39338.0 46196.8 46658.8 46989.8 47144.3 48302.0 17769.2 18173.0 18239.8 18241.9 18314.8 18387.2 19119.3 19382.3 19438.7 19488.6 17964.1 18007.8 18023.4 18196.1 18272.2 18609.9 18783.0 18861.2 19010.0 19011.0 16911.2 17013.2 17065.0 17088.7 17176.9 12764.4 13638.2 13826.2 13887.0 14177.8 13077.9 13359.0 13459.1 14048.0 14314.6 18:59:42 INFO - PID 25462 | -------- Summary: end -------- 18:59:42 INFO - PID 25462 | 18:59:42 INFO - TEST-INFO | 25462: exit 0 18:59:42 INFO - TEST-OK | dromaeo_css | took 1113452ms 18:59:42 INFO - TEST-START | kraken 18:59:42 INFO - Initialising browser for kraken test... 18:59:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html -profile /tmp/tmp1Ru2gg/profile 18:59:42 INFO - TEST-INFO | started process 25834 (/builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html) 18:59:48 INFO - TEST-INFO | 25834: exit 0 18:59:49 INFO - Browser initialized. 18:59:49 INFO - Running cycle 1/1 for kraken test... 18:59:49 INFO - TEST-INFO | started process 26060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Ru2gg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:00 INFO - PID 26060 | RSS: Main: 175894528 19:00:00 INFO - PID 26060 | 19:00:03 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:04 INFO - PID 26060 | RSS: Main: 179716096 19:00:04 INFO - PID 26060 | 19:00:06 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-dft) 19:00:07 INFO - PID 26060 | RSS: Main: 180981760 19:00:07 INFO - PID 26060 | 19:00:10 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-fft) 19:00:11 INFO - PID 26060 | RSS: Main: 174845952 19:00:11 INFO - PID 26060 | 19:00:13 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator) 19:00:13 INFO - PID 26060 | RSS: Main: 176254976 19:00:13 INFO - PID 26060 | 19:00:16 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:16 INFO - PID 26060 | RSS: Main: 176640000 19:00:16 INFO - PID 26060 | 19:00:19 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:20 INFO - PID 26060 | RSS: Main: 178245632 19:00:20 INFO - PID 26060 | 19:00:23 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:24 INFO - PID 26060 | RSS: Main: 178036736 19:00:24 INFO - PID 26060 | 19:00:27 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial) 19:00:28 INFO - PID 26060 | RSS: Main: 178049024 19:00:28 INFO - PID 26060 | 19:00:29 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:30 INFO - PID 26060 | RSS: Main: 179437568 19:00:30 INFO - PID 26060 | 19:00:32 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:32 INFO - PID 26060 | RSS: Main: 178368512 19:00:32 INFO - PID 26060 | 19:00:34 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:35 INFO - PID 26060 | RSS: Main: 178176000 19:00:35 INFO - PID 26060 | 19:00:38 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:00:39 INFO - PID 26060 | RSS: Main: 179048448 19:00:39 INFO - PID 26060 | 19:00:42 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:00:42 INFO - PID 26060 | RSS: Main: 178819072 19:00:42 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40143/tests/kraken/driver.html?testName=ai-astar) 19:00:44 INFO - PID 26060 | RSS: Main: 180654080 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | __start_tp_report 19:00:44 INFO - PID 26060 | _x_x_mozilla_page_load 19:00:44 INFO - PID 26060 | _x_x_mozilla_page_load_details 19:00:44 INFO - PID 26060 | |i|pagename|runs| 19:00:44 INFO - PID 26060 | |0;ai-astar;106;110;97;108;113;111;115;111;113;116 19:00:44 INFO - PID 26060 | |1;audio-beat-detection;145;118;151;174;122;153;141;120;173;124 19:00:44 INFO - PID 26060 | |2;audio-dft;164;164;165;164;164;166;172;164;162;167 19:00:44 INFO - PID 26060 | |3;audio-fft;76;77;76;182;76;75;74;75;156;79 19:00:44 INFO - PID 26060 | |4;audio-oscillator;81;82;138;83;84;83;130;81;81;134 19:00:44 INFO - PID 26060 | |5;imaging-gaussian-blur;122;115;113;113;115;115;114;114;114;117 19:00:44 INFO - PID 26060 | |6;imaging-darkroom;150;152;149;151;150;150;151;151;159;151 19:00:44 INFO - PID 26060 | |7;imaging-desaturate;94;94;94;94;95;95;94;95;98;103 19:00:44 INFO - PID 26060 | |8;json-parse-financial;53;53;58;53;55;53;58;54;53;54 19:00:44 INFO - PID 26060 | |9;json-stringify-tinderbox;54;54;55;55;55;54;54;55;55;54 19:00:44 INFO - PID 26060 | |10;stanford-crypto-aes;77;91;78;79;83;78;77;88;87;77 19:00:44 INFO - PID 26060 | |11;stanford-crypto-ccm;135;139;136;137;130;134;131;131;135;167 19:00:44 INFO - PID 26060 | |12;stanford-crypto-pbkdf2;198;173;177;175;178;176;176;174;174;174 19:00:44 INFO - PID 26060 | |13;stanford-crypto-sha256-iterative;70;70;73;71;69;69;69;69;69;70 19:00:44 INFO - PID 26060 | __end_tp_report 19:00:44 INFO - PID 26060 | __start_cc_report 19:00:44 INFO - PID 26060 | _x_x_mozilla_cycle_collect,966 19:00:44 INFO - PID 26060 | __end_cc_report 19:00:44 INFO - PID 26060 | __startTimestamp1500948044810__endTimestamp 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | ------- Summary: start ------- 19:00:44 INFO - PID 26060 | Number of tests: 14 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#0] ai-astar Cycles:10 Average:110.00 Median:113.00 stddev:5.48 (4.8%) stddev-sans-first:5.61 19:00:44 INFO - PID 26060 | Values: 106.0 110.0 97.0 108.0 113.0 111.0 115.0 111.0 113.0 116.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:148.00 stddev:21.03 (14.2%) stddev-sans-first:22.28 19:00:44 INFO - PID 26060 | Values: 145.0 118.0 151.0 174.0 122.0 153.0 141.0 120.0 173.0 124.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:2.74 (1.7%) stddev-sans-first:2.87 19:00:44 INFO - PID 26060 | Values: 164.0 164.0 165.0 164.0 164.0 166.0 172.0 164.0 162.0 167.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.71 (52.3%) stddev-sans-first:41.55 19:00:44 INFO - PID 26060 | Values: 76.0 77.0 76.0 182.0 76.0 75.0 74.0 75.0 156.0 79.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:81.50 stddev:25.14 (30.8%) stddev-sans-first:25.93 19:00:44 INFO - PID 26060 | Values: 81.0 82.0 138.0 83.0 84.0 83.0 130.0 81.0 81.0 134.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:2.66 (2.3%) stddev-sans-first:1.24 19:00:44 INFO - PID 26060 | Values: 122.0 115.0 113.0 113.0 115.0 115.0 114.0 114.0 114.0 117.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:2.80 (1.9%) stddev-sans-first:2.92 19:00:44 INFO - PID 26060 | Values: 150.0 152.0 149.0 151.0 150.0 150.0 151.0 151.0 159.0 151.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.50 stddev:2.88 (3.0%) stddev-sans-first:2.99 19:00:44 INFO - PID 26060 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 98.0 103.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:2.01 (3.7%) stddev-sans-first:2.07 19:00:44 INFO - PID 26060 | Values: 53.0 53.0 58.0 53.0 55.0 53.0 58.0 54.0 53.0 54.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:55.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 19:00:44 INFO - PID 26060 | Values: 54.0 54.0 55.0 55.0 55.0 54.0 54.0 55.0 55.0 54.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:5.34 (6.6%) stddev-sans-first:5.41 19:00:44 INFO - PID 26060 | Values: 77.0 91.0 78.0 79.0 83.0 78.0 77.0 88.0 87.0 77.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:135.50 stddev:10.75 (7.9%) stddev-sans-first:11.37 19:00:44 INFO - PID 26060 | Values: 135.0 139.0 136.0 137.0 130.0 134.0 131.0 131.0 135.0 167.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:176.00 stddev:7.37 (4.2%) stddev-sans-first:1.64 19:00:44 INFO - PID 26060 | Values: 198.0 173.0 177.0 175.0 178.0 176.0 176.0 174.0 174.0 174.0 19:00:44 INFO - PID 26060 | 19:00:44 INFO - PID 26060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.29 (1.8%) stddev-sans-first:1.36 19:00:44 INFO - PID 26060 | Values: 70.0 70.0 73.0 71.0 69.0 69.0 69.0 69.0 69.0 70.0 19:00:44 INFO - PID 26060 | -------- Summary: end -------- 19:00:44 INFO - PID 26060 | 19:00:45 INFO - PID 26060 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:00:45 INFO - TEST-INFO | 26060: exit 0 19:00:45 INFO - TEST-OK | kraken | took 62752ms 19:00:45 INFO - SUITE-END | took 1176s 19:00:45 INFO - Completed test suite (00:19:36) 19:00:45 INFO - javascript benchmark 19:00:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8398.051656413578, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.0459459864746, 3133.655297917229, 3179.491281394976, 3181.5863937688096, 3233.7898036627616, 6061.727222274997, 6187.226596675416, 6254.874902501947, 6284.654344011077, 6306.842328941773, 6171.598846075013, 6210.503159747221, 6212.5961812482155, 6218.657973811439, 6270.216222972129, 5680.0, 5713.14302854572, 5715.342735585419, 5725.255716756816, 5738.3974682658345, 5786.479216870481, 5797.594168408213, 5808.622439541437, 5824.708764561755, 5843.328017278003, 5671.602987790856, 5729.684867332295, 5731.254936858223, 5734.541236701054, 5773.1051686988585, 5495.862603434906, 5609.074502707049, 5632.662040277555, 5711.62874413166, 5758.740856661419, 5627.212190293362, 5662.094064949588, 5707.800226992035, 5739.483446489836, 5748.0, 6050.062240352752, 6052.576319657625, 6094.786682466092, 6133.325334213233, 6154.1999540059505, 6626.204855417381, 6643.60138391698, 6694.631795251259, 6714.5971241725165, 6717.227518835348, 6669.066330713704, 6687.732490700366, 6763.323667633246, 6765.255821859591, 6783.966080169617, 6103.542234332443, 6182.289036760785, 6199.442050215503, 6200.627962322275, 6246.718897649616, 6755.898661520081, 6899.689513971884, 6910.239873613898, 6946.0622815920215, 6947.89578156328, 6492.415682588496, 6516.967415162989, 6582.539222254492, 6613.834654133589, 6620.503462240351, 6634.933650663432, 6643.534952553275, 6647.368499992493, 6730.394264516217, 6763.898541521881, 6477.676116194266, 6600.966995164993, 6621.304762999912, 6680.565763225375, 6763.458923286125, 6610.86778264432, 6689.063531105649, 6705.362990515893, 6712.597244165366, 6722.092517510171, 5310.097283461821, 5312.123499622597, 5328.094223981932, 5382.973085134628, 5402.054640437907, 4494.73031618104, 4554.749488778083, 4558.954410455853, 4566.223741963874, 4656.4877863434995, 5794.739236734357, 5868.354481007086, 5877.0302900021015, 5878.088896221093, 5888.293404791452, 6669.666516674147, 6676.098726671934, 6761.3238676132, 6774.8645027100165, 6828.624425656637, 5660.603757736919, 5687.544996400278, 5742.799002034993, 5753.108268218432, 5853.560982926298, 5815.651060936358, 5892.558058145571, 5908.556858235649, 5913.526917846648, 5918.319393269743, 6499.935000649933, 6500.3174666659315, 6561.835954101186, 6588.439982601437, 6607.801765947125, 6651.7006734698025, 6705.362990515893, 6713.899291510729, 6720.563163394364, 6826.795196144124, 6475.708593113227, 6483.578567393104, 6492.058651495412, 6536.575122617015, 6553.737850485927, 6528.445082168069, 6564.245111812203, 6632.336766323329, 6663.033860090163, 6694.765683201259, 6587.440067594308, 6674.332566743286, 6720.1263835703, 6742.69657865407, 6828.522003459909, 6415.518836087219, 6444.709988050456, 6447.484201263981, 6478.449331806661, 6478.870422591616, 6489.415952564292, 6489.610623362613, 6552.901706474502, 6557.508186885907, 6568.573042752206, 6352.68236588178, 6397.840053998687, 6451.580647257913, 6455.0962865199845, 6470.320616335217, 6472.967635161794, 6549.574277671936, 6550.344965503412, 6621.834454138685, 6630.734770609314, 6230.06549017651, 6310.400511951358, 6325.620462772248, 6376.585521941059, 6381.521385895983], "value": 6093.69544224746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.5639539241897, 863.9827203455931, 875.8467268228059, 879.2965627498, 1163.4996951310943, 31089.222769430748, 31650.525242121388, 31674.84162579187, 42757.0, 43290.567094329046, 42694.14611707764, 43045.35431968515, 43235.0, 43416.0, 43453.0, 7194.20863704992, 7624.580648064354, 7695.8076048098965, 7728.497647652885, 7761.8059548511455, 7588.354989825843, 7729.227077292282, 7730.072391313022, 7737.07155141381, 7742.032245969254, 7564.0, 7607.0, 7608.885866712004, 7648.273414025659, 7671.156172820985, 7541.283578060075, 7584.810379740496, 7626.084869815602, 7626.885596716053, 7638.274363935418, 7487.588182649952, 7504.249575042507, 7516.473846830724, 7521.811954701122, 7536.284053014955, 38570.61429385698, 38701.225975480615, 38778.418323725164, 38822.80588597067, 38917.805410973044, 3548.8048157351336, 3589.94615080774, 3590.1563132663805, 3595.7123430125525, 3599.4240921452442, 31722.841385793155, 31734.523982140287, 31759.682403175902, 31762.523562146587, 31808.0, 4892.266160075981, 4990.8752281193265, 4991.226359914219, 5004.749762511896, 5040.269160971675, 186047.0, 186264.0, 187117.0, 187509.0, 187533.0, 46965.29552056722, 47101.528984709716, 47184.0, 47252.76373618178, 47293.76353118212, 50009.24986125211, 50146.0, 50185.498145018086, 50192.49807501951, 50206.49793502091, 15978.920105399631, 16347.427840025543, 16399.0, 16404.09777462227, 16420.507384778477, 11700.0, 11792.823107653392, 13552.390142443614, 13566.864331356757, 13723.725525489433, 14388.928055359656, 14518.128912265087, 14610.415583376545, 14780.704385912437, 14808.777868331983, 5824.6020954971345, 5939.287285525765, 5962.880742385215, 5972.0, 5979.19280897082, 954.6706386296717, 987.5506644476745, 1000.0999100809184, 1001.5993602559034, 1005.7485628592851, 21457.67813482799, 22043.559128817335, 22098.779012209994, 22144.88927555352, 22231.555368892532, 1079.624825384158, 1089.7548051688307, 1099.6041425086962, 1118.9160812939062, 1122.9382383968796, 11511.654650360502, 11607.535698572132, 11921.28472291648, 15725.213739312989, 16126.113063781604, 241642.0, 243862.0, 244359.0, 244412.0, 244566.0, 56207.0, 56852.14721779177, 56908.43091569031, 56950.57623559361, 56993.71503142541, 1424.522784867081, 1444.415011920174, 1449.7607894697258, 1456.8251809782682, 1461.8099647045815, 25621.487570248864, 26953.730462695905, 27038.72961270362, 27068.45863082688, 27496.0, 52015.2197717027, 52021.7398913003, 52058.0, 52348.47651523436, 52486.21270680866, 211320.0, 211466.0, 212221.0, 212373.0, 213096.0, 37459.81270093632, 37713.24573508569, 37790.244195115396, 38688.41967370435, 38733.0, 45778.31332529948, 47357.52642473531, 47733.76133119451, 47834.521654783006, 47866.760666196446, 33386.0, 34362.65637343695, 34626.48060279148, 34699.13252168716, 34925.30149396947, 31947.6805231954, 33276.66723332736, 34226.48660270048, 34468.0, 34943.65056349404, 37228.62771372252, 37478.0, 37498.81250593839, 37676.43485347667, 37795.24409511849, 30891.227719307197, 32890.67109328876, 33467.0, 33524.66475335313, 33641.327173456884, 23951.401214969766, 24023.0, 24519.509609807348, 24698.753012469646, 24718.876405617855], "value": 17662.83974682725, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.6014722604584, 552.3371953655612, 569.2827037932204, 582.3710392775799, 584.1733946465752, 21852.0, 22824.20115295965, 22824.31527054187, 22837.08651653934, 22851.885740571317, 25042.49915001699, 25860.353491162732, 25910.611340829902, 25954.48091038183, 25966.610500842457, 6500.707468163932, 6654.600723956554, 6656.101426307435, 6666.933330666704, 6680.031395447657, 6021.096835474692, 6490.675466226693, 6524.7063882125185, 6541.869162616745, 6551.737930482775, 6494.155759751226, 6496.870062598745, 6497.415232629062, 6526.543141980063, 6528.0, 6470.4823614110755, 6490.253620833618, 6522.347765223463, 6523.380278873499, 6526.412622863965, 6038.305594856603, 6048.69756512177, 6065.696715164224, 6072.483838873701, 6075.848103797396, 29389.412211755644, 29523.261918451997, 30039.399212015855, 30981.22546936322, 31003.379932401225, 1858.2009735813594, 1897.6963685810342, 1897.7153426985924, 1898.6202759448026, 1902.048975512244, 19240.903795481074, 19329.0, 20034.79965200344, 20058.598828023503, 20211.696824547642, 2323.697919270484, 2365.47959448921, 2368.017272831773, 2373.964390534143, 2392.6650268962358, 133326.3333683335, 140809.0, 141057.58942410548, 141251.29374353166, 141440.0, 14819.77770333446, 14860.256987150598, 15304.693906121815, 15664.373425063097, 15735.527934161993, 23476.178333758235, 23545.646815297783, 23559.293221203392, 23571.76428235696, 23595.76404235936, 9150.908490915006, 9174.86237706435, 9221.769455763526, 9278.304127190488, 9330.066993300616, 8129.634166462523, 8226.712065077694, 8308.12764659714, 8316.625751841182, 8872.911270887209, 8842.381033327605, 9247.861282080774, 9397.624095036259, 9424.0, 9557.139857412867, 2563.2310306907852, 2579.303588031221, 2641.3924797296345, 2662.108193755114, 2774.3480282133683, 964.4417084395983, 974.2108891797667, 982.8820541535061, 1005.4218824176128, 1010.075780660702, 19327.710084348746, 19551.0, 19608.90195549013, 19779.0, 20434.591308173753, 997.7056768253383, 1028.228828378716, 1039.0752230514847, 1040.9011143941314, 1050.6375300521308, 10799.0, 10948.507317170746, 10993.670189894316, 11158.944205278922, 11247.762746097922, 512884.0, 520997.0, 521893.0, 523041.0, 525524.0, 110235.0, 114423.42788286172, 114750.42624786822, 115244.0, 116109.0, 1241.7516496700696, 1271.9809202861964, 1295.1646188208554, 1298.078364361314, 1299.064673435125, 16802.747958780383, 17486.562835929202, 17625.471235862944, 17697.115144242995, 18184.90907545454, 52447.0, 53275.0, 53822.0, 54296.18555721588, 54406.72796635992, 66092.0, 67836.32163678498, 68480.3151968474, 69631.6518417425, 70523.29476705167, 14260.0, 14572.198529081003, 15151.015184013004, 15231.619209519851, 15292.61768455753, 22965.65551516762, 23829.761702382755, 24152.396190095387, 24180.153694620603, 24239.878800605886, 18759.718604220674, 18760.718589220898, 18830.811691882907, 19044.71432928535, 19083.713744293567, 16743.0, 16844.410445634836, 17188.914055430145, 17321.480355589352, 17466.388676396775, 18727.250909963448, 19226.0, 19420.8057919419, 19492.220311187393, 19510.0, 14862.777058343918, 15060.698786024437, 15151.848481515044, 15158.469453569513, 15174.317155727798, 16589.75115373246, 17219.22513486921, 17234.569135771708, 17249.827501725325, 17319.0], "value": 11932.069547375457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.2771789374792, 1382.1361648969394, 1391.3599744117705, 1396.2320723602015, 1400.334840950548, 13081.476740930351, 13113.7377252455, 13819.723605527883, 13866.0, 13911.443542258323, 14051.43794248229, 14176.291185440738, 14262.286885655727, 14277.071990320648, 14338.283085845718, 2595.8961641534365, 2649.4436168404563, 2649.682038155424, 2652.2308530526125, 2662.986685066572, 2543.351445381425, 2691.3406215477235, 2700.635414219075, 2727.7681397081274, 2735.9452810943767, 2594.3254753764063, 2599.6230546570737, 2615.6338112664243, 2622.8819703113404, 2623.3966187776823, 2587.987060064697, 2627.487639910218, 2630.1846427607406, 2633.0, 2636.4331668691134, 2595.1046888823325, 2605.231456720253, 2616.3589920469417, 2616.5290247755397, 2617.0, 13603.251821149834, 13688.452461901512, 13839.0, 13858.65353366174, 13862.237576933265, 7323.670434830446, 7495.812604684872, 7532.736354227631, 7814.1013783415065, 7816.648250828726, 4991.126552853236, 5195.142801437758, 5235.240890070956, 5288.947110528884, 5302.522772950453, 1778.5998150416183, 1780.5904641932298, 1803.9007854567994, 1843.3916807453643, 1845.5386153461634, 21276.148954041975, 21516.139354425803, 21576.24483143098, 21584.460388490257, 21612.135514579397, 6220.253569571681, 6295.244570651551, 6327.082573026977, 6412.070249813844, 6426.068220108058, 14993.700125997637, 15033.173175475455, 15075.396984120513, 15080.773788393182, 15103.773443398359, 7098.0, 7698.730544430918, 7709.884351734729, 7714.305712485903, 7756.806079848049, 6499.0, 6834.453243740489, 6849.349311815369, 6991.580505169706, 6994.195667498303, 4935.605151587864, 4992.475790041994, 5022.171341728574, 5126.871828204325, 5147.6911385317, 1484.4952716076587, 1494.2603411311254, 1502.6393665520197, 1503.3688448034006, 1523.0785374848058, 882.5543100734088, 895.7536677413633, 900.3697411811758, 916.5829547555846, 923.132255679659, 6697.598144111369, 6807.931920680829, 6896.896546551806, 7033.929660703429, 7064.0, 652.5693042591867, 713.9500234983606, 736.9336759691654, 741.0440531714029, 752.2966026764992, 4290.377895205178, 4629.768511574475, 4675.602573781199, 4922.778474968635, 4965.155923493015, 17404.129793510274, 17833.375831846082, 18059.909700451677, 18079.909600452178, 18134.727979080326, 17725.556861078578, 18761.53096172579, 18839.0, 18846.43460696181, 18914.716279255823, 10008.14930730896, 10145.137663298703, 10153.441560714231, 10156.644517442002, 10239.59041638341, 7348.889766653611, 8181.877271840808, 8259.587020648823, 8295.751127465945, 8385.077641459313, 15264.771028434805, 16015.839841601435, 16161.515154545383, 16304.103274320027, 16591.25339359756, 15440.150791706565, 15947.44183953556, 16213.0, 16659.416920407726, 16832.663346733243, 10762.784744304914, 10939.50772215268, 10944.507497162806, 10966.177536684621, 10996.890031099907, 12534.059945504307, 12602.369881505705, 12627.810582841448, 12662.683432914251, 12664.366781660696, 10026.348287361297, 10223.131033861908, 10565.683029509128, 10736.0, 10795.892041079804, 9698.6120555177, 10211.438370889673, 10238.385696858213, 10351.689449316533, 10619.15046796239, 9292.070792920655, 9335.766605834908, 9396.342256042011, 9401.623935042795, 9422.57598408087, 6572.375624315682, 6910.239873613999, 7020.087388639648, 7079.504434689522, 7148.892766608609, 6977.895331570132, 7005.894911576433, 7020.543664661781, 7026.929730702832, 7138.143422789299], "value": 6164.04808515702, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.0775218942591, 491.69760597232704, 502.74611321282754, 503.09191908604953, 515.5102652480142, 6084.269887613487, 6107.38926107389, 6196.442320191182, 6199.582162956451, 6262.185915830942, 5916.792912248072, 6052.001419765734, 6088.48247898928, 6099.756009759604, 6104.938950610493, 4878.34142390778, 4886.242632391985, 4887.193613053851, 4902.0931127741305, 4941.579965702902, 4917.72952487613, 4918.729469879156, 4922.68002579833, 4925.852224433254, 4980.327655766461, 4738.834140805073, 4878.317035615017, 4878.853634390974, 4910.877228069291, 4942.308076869242, 4859.489753575876, 4877.317175595419, 4911.214205727067, 4945.975270123644, 4955.603551715854, 4414.227510185705, 4429.844955426577, 4442.8667139985855, 4448.421705178306, 4453.688241823073, 5997.760089596411, 6015.27816661999, 6032.125341825411, 6065.5450841187085, 6170.673305239395, 5622.0, 5649.209110724501, 5655.519280861132, 5704.372519022904, 5715.428457154293, 6408.23101227851, 6423.96788016057, 6442.936915408952, 6465.709043093072, 6482.967585162091, 4784.330193772875, 4893.657443978923, 4898.412190537123, 4898.461169271377, 4906.043321552299, 6903.37770623903, 6931.643241297932, 6932.168139823253, 6934.791956241321, 6938.236793952661, 4934.851954441301, 4990.775415106329, 4993.925091123636, 5010.549050585392, 5025.3416372597685, 5041.092603331363, 5059.949400506021, 5083.822066227738, 5094.414142373675, 5105.744712764347, 5544.004158502936, 5582.720863956867, 5634.85912852182, 5642.758593109592, 5675.1487276907965, 6445.838854028593, 6499.675016249169, 6509.2839787623325, 6544.44372228366, 6616.702248398834, 1627.9267432965546, 1659.9874076813135, 1704.5994191365019, 1723.4488959936157, 1742.3553285284272, 1126.707056165403, 1201.6935681401187, 1203.7472130852618, 1210.903127749778, 1231.815227715832, 5638.0, 5701.857453563694, 5743.62666426681, 5770.221020162308, 5780.219670344533, 6453.483721302378, 6536.901946470807, 6580.539362244693, 6600.933990660032, 6630.0, 5653.378128405872, 5655.745491452894, 5681.375048744635, 5691.573132015115, 5765.8558536036935, 3543.698785603201, 3588.5334906462517, 3589.425691889285, 3619.1675914539805, 3628.3650361186687, 6465.64438955862, 6520.282768895418, 6530.2816690164045, 6531.902021469682, 6542.967285163544, 6886.51794374389, 6904.620245886424, 6941.895871561931, 6969.860602787916, 6990.685419156151, 6399.6800159992745, 6403.743850245938, 6428.8071357859335, 6461.773837915651, 6504.577202481823, 6652.434543063894, 6713.597184168965, 6730.754810360099, 6758.560693554903, 6772.255051944184, 6575.671216439255, 6615.536912416084, 6648.16897887764, 6666.766663166766, 6683.966580167068, 6345.0, 6420.518461115342, 6446.9355306448215, 6500.382463665944, 6524.836879078061, 4895.926561101515, 4899.559039686445, 4909.26361045846, 4975.975120124376, 4982.227754698028, 6694.121527743117, 6698.799036028927, 6770.0, 6773.864522709617, 6822.692978815866, 6308.905366419599, 6396.232452105777, 6447.580907241202, 6476.805695829133, 6582.473402127723, 6379.840503987438, 6459.386358295955, 6461.029386037304, 6471.644059576768, 6532.9346706534225, 5925.585209035326, 6089.0, 6167.938320616737, 6238.376162383725, 6271.463491444625, 6501.317361676955, 6517.3808488193545, 6518.120053792867, 6557.672116394257, 6567.671616419065, 6220.813375598739, 6274.925286609619, 6327.658766256514, 6335.3981371769605, 6337.017762246859], "value": 5004.742146261115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.5904787799391, 840.4915026409026, 851.3189448441245, 907.7231444409455, 932.6828878181419, 16717.916410417947, 17220.0, 17236.224369903353, 17316.82683173168, 21899.124035038578, 20035.59928801423, 21032.579348413023, 21043.894780526076, 21167.259145929896, 21190.25834095807, 1026.7741096958694, 1054.4411461925154, 1056.0442799266636, 1062.9681109566725, 1063.1176123817252, 1013.3583594576796, 1047.4919663962971, 1059.1950117910367, 1059.629129804566, 1062.4900047976976, 1103.1671088328342, 1105.082781291526, 1106.1758989552795, 1107.7839821234863, 1111.0, 1092.4919912240807, 1102.509383324421, 1103.6082190822224, 1103.8675358956896, 1112.7496313329516, 802.4062193976474, 809.3161278719473, 809.5142914251461, 811.853866304065, 817.709713051864, 17884.642307153914, 18335.17491712863, 18365.173567189508, 18391.448256552325, 19383.903080484648, 20554.486137846525, 20573.4856628584, 20893.0, 21107.15571377143, 21193.0, 15871.841281587152, 15872.52382428529, 16165.4342098026, 16322.510324690278, 16393.508194754177, 3550.786952782841, 3564.9643503565153, 3570.9285814283567, 3581.230035542371, 3587.6412358763914, 115057.42471287673, 118284.40857795656, 120119.17437750837, 123452.0, 123615.0, 15603.609909752347, 16719.91640041792, 16734.916325418297, 16737.0, 16767.077810720282, 30319.0, 30380.392392152033, 30544.236394090327, 30592.388152236832, 30653.84673076665, 6839.794806155824, 7188.388986936169, 7235.674394652148, 7310.59791711461, 7333.413326933833, 3889.53325600924, 4008.0581063450068, 4011.956891208307, 4022.4770779799023, 4026.859059932888, 5017.272495488134, 5122.692638441706, 5185.662931909414, 5193.662411943212, 5224.268602395668, 983.5819776594918, 1002.1231422505308, 1011.4083261292079, 1011.4740335025746, 1018.556927736437, 564.5568228940263, 614.5882258886556, 620.4106099205773, 635.6059243269202, 664.2129077043719, 10501.9474902625, 11441.885581144248, 11536.94231528837, 12951.611451656465, 13723.794143087862, 692.9237783843773, 694.7568351077083, 695.9617221052789, 698.7414656577099, 706.8162277807704, 5561.833145005657, 5770.278715160605, 6055.303640081447, 6056.57603967718, 6224.408681175281, 100756.49621751845, 101026.4948675252, 102309.0, 105301.0, 105826.0, 81338.0, 88363.11636883678, 88624.55687721648, 89222.0, 90468.0, 71944.28055719481, 73722.26277737261, 77013.22986770172, 78316.21683783203, 79663.60168199122, 11876.228045177037, 12053.879461205626, 12503.499860005499, 12504.792109573706, 12531.87468125307, 35145.0, 36628.63371366252, 37660.0, 38351.80824095861, 39338.016549586486, 46196.76901615471, 46658.76670616625, 46989.76505117589, 47144.29283560818, 48302.0, 17769.200385982404, 18173.0, 18239.817601823812, 18241.908790456495, 18314.81685183131, 18387.17257723379, 19119.330823421114, 19382.321618743277, 19438.708419374005, 19488.61022779565, 17964.10179490994, 18007.819921800616, 18023.369182078564, 18196.09019548991, 18272.17775200146, 18609.90695046516, 18783.0, 18861.15124819359, 19010.049497525346, 19010.95439750827, 16911.238994245043, 17013.23440445158, 17065.0, 17088.658226835643, 17176.914115429343, 12764.42560084817, 13638.181709097486, 13826.170429774245, 13887.0, 14177.787333189804, 13077.934610326887, 13359.0, 13459.139959871962, 14048.0, 14314.642133946734], "value": 8853.973681288338, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 97.0, 108.0, 113.0, 111.0, 115.0, 111.0, 113.0, 116.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 151.0, 174.0, 122.0, 153.0, 141.0, 120.0, 173.0, 124.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 164.0, 164.0, 166.0, 172.0, 164.0, 162.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 182.0, 76.0, 75.0, 74.0, 75.0, 156.0, 79.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 138.0, 83.0, 84.0, 83.0, 130.0, 81.0, 81.0, 134.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 113.0, 113.0, 115.0, 115.0, 114.0, 114.0, 114.0, 117.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 149.0, 151.0, 150.0, 150.0, 151.0, 151.0, 159.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 98.0, 103.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 53.0, 55.0, 53.0, 58.0, 54.0, 53.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 91.0, 78.0, 79.0, 83.0, 78.0, 77.0, 88.0, 87.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 136.0, 137.0, 130.0, 134.0, 131.0, 131.0, 135.0, 167.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 173.0, 177.0, 175.0, 178.0, 176.0, 176.0, 174.0, 174.0, 174.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 71.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0], "value": 69.9, "unit": "score"}]}]} 19:00:45 INFO - Return code: 0 19:00:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:00:46 INFO - # TBPL SUCCESS # 19:00:46 INFO - Running post-action listener: _package_coverage_data 19:00:46 INFO - Running post-action listener: _resource_record_post_action 19:00:46 INFO - [mozharness: 2017-07-25 02:00:46.071852Z] Finished run-tests step (success) 19:00:46 INFO - Running post-run listener: _resource_record_post_run 19:00:46 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437850112; Read time: 12; Write time: 297624 19:00:46 INFO - TinderboxPrint: CPU usage
13.2% 19:00:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:00:46 INFO - TinderboxPrint: I/O write bytes / time
437,850,112 / 297,624 19:00:46 INFO - TinderboxPrint: CPU idle
8,272.2 (86.8%) 19:00:46 INFO - TinderboxPrint: CPU user
1,204.8 (12.6%) 19:00:46 INFO - TinderboxPrint: Swap in / out
0 / 0 19:00:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107503616; Read time: 0; Write time: 99412 19:00:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:00:46 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 330346496; Read time: 0; Write time: 198212 19:00:46 INFO - Running post-run listener: _upload_blobber_files 19:00:46 INFO - Blob upload gear active. 19:00:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:00:46 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 19:00:46 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'] 19:00:46 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 19:00:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:50 INFO - (blobuploader) - INFO - Done attempting. 19:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:00:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:50 INFO - (blobuploader) - INFO - Done attempting. 19:00:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:00:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:00:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:51 INFO - (blobuploader) - INFO - Done attempting. 19:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:00:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:52 INFO - (blobuploader) - INFO - Done attempting. 19:00:52 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:52 INFO - Return code: 0 19:00:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:00:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c294725880e6a0682d0c198d3812ac9293dc82542adf0932e7a345c6864e39c10053e2e52f787e3344c53991aae18c64bdb704dc2f0d994d1513052bae24dfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60745ffc6fb63089a9637735b7876fbe5e8ea605033e6a17fa879c5a01a9f4c4f8d2f86c2c47e2108d24d9493aaa29f98a0c1841654deca9f62aba6a81a0334", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea6da7081bffdd6d64b2be60e20e68a9e968824af0513b6689eaf5808b5a5a0330bd3624c7e8c3d9b7b853b2caa7a3e758507640841252db9adb8abe405a4f60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324d5f887bb5d123271c3dc94331b957860b3dca2e66c2c18984dab052e753cb9330d351e7c608a95cd4b4b2e6bb5fde3090444fa95c595710542ec092a42395"} 19:00:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:00:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:00:52 INFO - Contents: 19:00:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c294725880e6a0682d0c198d3812ac9293dc82542adf0932e7a345c6864e39c10053e2e52f787e3344c53991aae18c64bdb704dc2f0d994d1513052bae24dfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60745ffc6fb63089a9637735b7876fbe5e8ea605033e6a17fa879c5a01a9f4c4f8d2f86c2c47e2108d24d9493aaa29f98a0c1841654deca9f62aba6a81a0334", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea6da7081bffdd6d64b2be60e20e68a9e968824af0513b6689eaf5808b5a5a0330bd3624c7e8c3d9b7b853b2caa7a3e758507640841252db9adb8abe405a4f60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324d5f887bb5d123271c3dc94331b957860b3dca2e66c2c18984dab052e753cb9330d351e7c608a95cd4b4b2e6bb5fde3090444fa95c595710542ec092a42395"} 19:00:52 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:52 INFO - Copying logs to upload dir... 19:00:52 INFO - mkdir: /builds/slave/test/build/upload/logs 19:00:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.851698 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-24 19:00:52.206919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:52.213680) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c294725880e6a0682d0c198d3812ac9293dc82542adf0932e7a345c6864e39c10053e2e52f787e3344c53991aae18c64bdb704dc2f0d994d1513052bae24dfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60745ffc6fb63089a9637735b7876fbe5e8ea605033e6a17fa879c5a01a9f4c4f8d2f86c2c47e2108d24d9493aaa29f98a0c1841654deca9f62aba6a81a0334", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea6da7081bffdd6d64b2be60e20e68a9e968824af0513b6689eaf5808b5a5a0330bd3624c7e8c3d9b7b853b2caa7a3e758507640841252db9adb8abe405a4f60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324d5f887bb5d123271c3dc94331b957860b3dca2e66c2c18984dab052e753cb9330d351e7c608a95cd4b4b2e6bb5fde3090444fa95c595710542ec092a42395"} build_url:https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/Dmp9ImL6RGu0AuUgN83OtA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c294725880e6a0682d0c198d3812ac9293dc82542adf0932e7a345c6864e39c10053e2e52f787e3344c53991aae18c64bdb704dc2f0d994d1513052bae24dfc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60745ffc6fb63089a9637735b7876fbe5e8ea605033e6a17fa879c5a01a9f4c4f8d2f86c2c47e2108d24d9493aaa29f98a0c1841654deca9f62aba6a81a0334", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea6da7081bffdd6d64b2be60e20e68a9e968824af0513b6689eaf5808b5a5a0330bd3624c7e8c3d9b7b853b2caa7a3e758507640841252db9adb8abe405a4f60", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/324d5f887bb5d123271c3dc94331b957860b3dca2e66c2c18984dab052e753cb9330d351e7c608a95cd4b4b2e6bb5fde3090444fa95c595710542ec092a42395"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:52.252034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:52.252405) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1500944183.883459-879653358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-24 19:00:52.307889) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:00:52.308212) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-24 19:00:52.308527) ========= ========= Total master_lag: 0.21 =========