builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1502228942.98 results: success (0) revision: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:02.983548) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:02.983972) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:02.984277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:03.057556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:03.057844) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 14:49:03-- 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% 228M=0s 2017-08-08 14:49:03 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078972 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:03.187011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:03.193402) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019741 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:03.301956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-08 14:49:03.309322) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 --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 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 --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=23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 14:49:03,732 truncating revision to first 12 chars 2017-08-08 14:49:03,732 Setting DEBUG logging. 2017-08-08 14:49:03,732 attempt 1/10 2017-08-08 14:49:03,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/40004a53d1d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 14:49:04,511 unpacking tar archive at: mozilla-central-40004a53d1d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.089626 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-08 14:49:04.426208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:04.429589) ========= script_repo_revision: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:04.430020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:04.430313) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:49:04.439835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-08 14:49:04.440211) ========= /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=23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:49:04 INFO - MultiFileLogger online at 20170808 14:49:04 in /builds/slave/test 14:49:04 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 14:49:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:49:04 INFO - {'append_to_log': False, 14:49:04 INFO - 'base_work_dir': '/builds/slave/test', 14:49:04 INFO - 'blob_upload_branch': 'Firefox', 14:49:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:49:04 INFO - 'branch': 'Firefox', 14:49:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:49:04 INFO - 'code_coverage': False, 14:49:04 INFO - 'config_files': ('talos/linux_config.py',), 14:49:04 INFO - 'default_actions': ('clobber', 14:49:04 INFO - 'read-buildbot-config', 14:49:04 INFO - 'download-and-extract', 14:49:04 INFO - 'populate-webroot', 14:49:04 INFO - 'create-virtualenv', 14:49:04 INFO - 'install', 14:49:04 INFO - 'setup-mitmproxy', 14:49:04 INFO - 'run-tests'), 14:49:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:49:04 INFO - 'disable_ccov_upload': False, 14:49:04 INFO - 'download_minidump_stackwalk': True, 14:49:04 INFO - 'download_symbols': 'ondemand', 14:49:04 INFO - 'enable_stylo': False, 14:49:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:49:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:49:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:49:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:49:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:49:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:49:04 INFO - 'gecko_profile': False, 14:49:04 INFO - 'gecko_profile_interval': 0, 14:49:04 INFO - 'installer_path': 'installer.exe', 14:49:04 INFO - 'log_level': 'info', 14:49:04 INFO - 'log_name': 'talos', 14:49:04 INFO - 'log_to_console': True, 14:49:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:49:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:49:04 INFO - 'opt_config_files': (), 14:49:04 INFO - 'pip_index': False, 14:49:04 INFO - 'suite': 'dromaeojs-e10s', 14:49:04 INFO - 'system_bits': '32', 14:49:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:49:04 INFO - 'title': 'talos-linux64-ix-074', 14:49:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:49:04 INFO - 'use_talos_json': True, 14:49:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:49:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:49:04 INFO - 'work_dir': 'build'} 14:49:04 INFO - [mozharness: 2017-08-08 21:49:04.959914Z] Running clobber step. 14:49:04 INFO - Running pre-action listener: _resource_record_pre_action 14:49:04 INFO - Running main action method: clobber 14:49:04 INFO - rmtree: /builds/slave/test/build 14:49:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:49:05 INFO - Running post-action listener: _resource_record_post_action 14:49:05 INFO - [mozharness: 2017-08-08 21:49:05.987271Z] Finished clobber step (success) 14:49:05 INFO - [mozharness: 2017-08-08 21:49:05.987374Z] Running read-buildbot-config step. 14:49:05 INFO - Running pre-action listener: _resource_record_pre_action 14:49:05 INFO - Running main action method: read_buildbot_config 14:49:05 INFO - Using buildbot properties: 14:49:05 INFO - { 14:49:05 INFO - "project": "", 14:49:05 INFO - "product": "firefox", 14:49:05 INFO - "who": "kwierso@gmail.com", 14:49:05 INFO - "installer_path": "public/build/target.tar.bz2", 14:49:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:49:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:49:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:49:05 INFO - "stage_platform": "linux64-stylosequential", 14:49:05 INFO - "basedir": "/builds/slave/test", 14:49:05 INFO - "buildnumber": 24, 14:49:05 INFO - "platform": "ubuntu64_hw_styloseq", 14:49:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:49:05 INFO - "slavebuilddir": "test", 14:49:05 INFO - "taskId": "P4nGFRgqRqyUqDEpghwXWA", 14:49:05 INFO - "branch": "mozilla-central", 14:49:05 INFO - "script_repo_revision": "production", 14:49:05 INFO - "revision": "40004a53d1d1a28b30f565ffc1329b1f28dfffd2", 14:49:05 INFO - "slavename": "talos-linux64-ix-074", 14:49:05 INFO - "repo_path": "mozilla-central" 14:49:05 INFO - } 14:49:05 INFO - Finding installer, test and symbols from parent task. 14:49:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4nGFRgqRqyUqDEpghwXWA'}, attempt #1 14:49:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4nGFRgqRqyUqDEpghwXWA'}, attempt #1 14:49:06 INFO - Task dependencies: ZRtnnw9hTj-zpiR_sx9VUw 14:49:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw'}, attempt #1 14:49:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json 14:49:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip 14:49:07 INFO - Running post-action listener: _resource_record_post_action 14:49:07 INFO - [mozharness: 2017-08-08 21:49:07.357385Z] Finished read-buildbot-config step (success) 14:49:07 INFO - [mozharness: 2017-08-08 21:49:07.357650Z] Running download-and-extract step. 14:49:07 INFO - Running pre-action listener: _resource_record_pre_action 14:49:07 INFO - Running main action method: download_and_extract 14:49:07 INFO - mkdir: /builds/slave/test/build/tests 14:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:07 INFO - trying https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json 14:49:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:49:07 INFO - Downloaded 989 bytes. 14:49:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:49:07 INFO - Using the following test package requirements: 14:49:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:49:07 INFO - u'common': [u'target.common.tests.zip'], 14:49:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:49:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:49:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:49:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:49:07 INFO - u'mozbase': [u'target.common.tests.zip'], 14:49:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:49:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:49:07 INFO - u'web-platform': [u'target.common.tests.zip', 14:49:07 INFO - u'target.web-platform.tests.tar.gz'], 14:49:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:49:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:49:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip 14:49:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:49:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip into memory 14:49:09 INFO - Content-Length response header: 54284810 14:49:09 INFO - Bytes received: 54284810 14:49:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:49:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip 14:49:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:49:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip into memory 14:49:21 INFO - Content-Length response header: 54284810 14:49:21 INFO - Bytes received: 54284810 14:49:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip 14:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:49:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip into memory 14:49:33 INFO - Content-Length response header: 14496008 14:49:33 INFO - Bytes received: 14496008 14:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:34 INFO - trying https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:49:35 INFO - Downloaded 61871458 bytes. 14:49:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:35 INFO - mkdir: /builds/slave/test/properties 14:49:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:49:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:49:35 INFO - Contents: 14:49:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:35 INFO - Running post-action listener: _resource_record_post_action 14:49:35 INFO - Running post-action listener: set_extra_try_arguments 14:49:35 INFO - [mozharness: 2017-08-08 21:49:35.417680Z] Finished download-and-extract step (success) 14:49:35 INFO - [mozharness: 2017-08-08 21:49:35.417780Z] Running populate-webroot step. 14:49:35 INFO - Running pre-action listener: _resource_record_pre_action 14:49:35 INFO - Running main action method: populate_webroot 14:49:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:49:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:49:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:49:35 INFO - 'tests': ['damp', 'tps']}, 14:49:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:49:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:49:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:49:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:49:35 INFO - 'other-e10s': {'tests': ['a11yr', 14:49:35 INFO - 'ts_paint', 14:49:35 INFO - 'tpaint', 14:49:35 INFO - 'sessionrestore', 14:49:35 INFO - 'sessionrestore_many_windows', 14:49:35 INFO - 'sessionrestore_no_auto_restore', 14:49:35 INFO - 'tabpaint']}, 14:49:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:49:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:49:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:49:35 INFO - 'tsvgr_opacity', 14:49:35 INFO - 'tart', 14:49:35 INFO - 'tscrollx', 14:49:35 INFO - 'tsvg_static']}, 14:49:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:49:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:35 INFO - 'talos_options': ['--mitmproxy', 14:49:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:35 INFO - '--firstNonBlankPaint'], 14:49:35 INFO - 'tests': ['tp6_google', 14:49:35 INFO - 'tp6_youtube', 14:49:35 INFO - 'tp6_amazon', 14:49:35 INFO - 'tp6_facebook']}, 14:49:35 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:35 INFO - 'talos_options': ['--stylo', 14:49:35 INFO - '--mitmproxy', 14:49:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:35 INFO - '--firstNonBlankPaint'], 14:49:35 INFO - 'tests': ['tp6_google', 14:49:35 INFO - 'tp6_youtube', 14:49:35 INFO - 'tp6_amazon', 14:49:35 INFO - 'tp6_facebook']}, 14:49:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:35 INFO - 'talos_options': ['--stylo', 14:49:35 INFO - '--stylo-threads=1', 14:49:35 INFO - '--mitmproxy', 14:49:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:35 INFO - '--firstNonBlankPaint'], 14:49:35 INFO - 'tests': ['tp6_google', 14:49:35 INFO - 'tp6_youtube', 14:49:35 INFO - 'tp6_amazon', 14:49:35 INFO - 'tp6_facebook']}, 14:49:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:49:35 INFO - 'talos_options': ['--xperf_path', 14:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:35 INFO - 'tests': ['tp5n']}}} 14:49:35 INFO - Running post-action listener: _resource_record_post_action 14:49:35 INFO - [mozharness: 2017-08-08 21:49:35.426254Z] Finished populate-webroot step (success) 14:49:35 INFO - [mozharness: 2017-08-08 21:49:35.426345Z] Running create-virtualenv step. 14:49:35 INFO - Running pre-action listener: _resource_record_pre_action 14:49:35 INFO - Running main action method: create_virtualenv 14:49:35 INFO - Creating virtualenv /builds/slave/test/build/venv 14:49:35 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 14:49:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:49:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:49:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:49:35 INFO - Using real prefix '/usr' 14:49:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:49:36 INFO - Installing distribute.............................................................................................................................................................................................done. 14:49:37 INFO - Installing pip.................done. 14:49:38 INFO - Return code: 0 14:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:49:38 INFO - Reading from file tmpfile_stdout 14:49:38 INFO - Output received: 14:49:38 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) 14:49:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49: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', 'pip>=1.5'] in /builds/slave/test/build 14:49: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 pip>=1.5 14:49:38 INFO - Using env: {'DISPLAY': ':0', 14:49:38 INFO - 'HOME': '/home/cltbld', 14:49:38 INFO - 'LANG': 'en_US.UTF-8', 14:49:38 INFO - 'LANGUAGE': 'en_US:en', 14:49:38 INFO - 'LOGNAME': 'cltbld', 14:49:38 INFO - 'MAIL': '/var/mail/cltbld', 14:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:38 INFO - 'MOZ_NO_REMOTE': '1', 14:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:38 INFO - 'NO_EM_RESTART': '1', 14:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:38 INFO - 'PWD': '/builds/slave/test', 14:49:38 INFO - 'SHELL': '/bin/bash', 14:49:38 INFO - 'SHLVL': '1', 14:49:38 INFO - 'TERM': 'linux', 14:49:38 INFO - 'TMOUT': '86400', 14:49:38 INFO - 'USER': 'cltbld', 14:49:38 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:38 INFO - '_': '/tools/buildbot/bin/python'} 14:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:38 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 14:49:38 INFO - Cleaning up... 14:49:38 INFO - Return code: 0 14:49:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49: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', '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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:49: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 psutil>=3.1.1 14:49:38 INFO - Using env: {'DISPLAY': ':0', 14:49:38 INFO - 'HOME': '/home/cltbld', 14:49:38 INFO - 'LANG': 'en_US.UTF-8', 14:49:38 INFO - 'LANGUAGE': 'en_US:en', 14:49:38 INFO - 'LOGNAME': 'cltbld', 14:49:38 INFO - 'MAIL': '/var/mail/cltbld', 14:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:38 INFO - 'MOZ_NO_REMOTE': '1', 14:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:38 INFO - 'NO_EM_RESTART': '1', 14:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:38 INFO - 'PWD': '/builds/slave/test', 14:49:38 INFO - 'SHELL': '/bin/bash', 14:49:38 INFO - 'SHLVL': '1', 14:49:38 INFO - 'TERM': 'linux', 14:49:38 INFO - 'TMOUT': '86400', 14:49:38 INFO - 'USER': 'cltbld', 14:49:38 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:38 INFO - '_': '/tools/buildbot/bin/python'} 14:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:38 INFO - Downloading/unpacking psutil>=3.1.1 14:49: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 14:49: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 14:49: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 14:49: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 14:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:39 INFO - Installing collected packages: psutil 14:49:39 INFO - Running setup.py install for psutil 14:49:39 INFO - building 'psutil._psutil_linux' extension 14:49:39 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 14:49:40 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 14:49:40 INFO - building 'psutil._psutil_posix' extension 14:49:40 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 14:49:40 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 14:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:40 INFO - Successfully installed psutil 14:49:40 INFO - Cleaning up... 14:49:40 INFO - Return code: 0 14:49:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:49:40 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')]} 14:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:40 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')]} 14:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:40 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:40 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 14:49:40 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 14:49:40 INFO - Using env: {'DISPLAY': ':0', 14:49:40 INFO - 'HOME': '/home/cltbld', 14:49:40 INFO - 'LANG': 'en_US.UTF-8', 14:49:40 INFO - 'LANGUAGE': 'en_US:en', 14:49:40 INFO - 'LOGNAME': 'cltbld', 14:49:40 INFO - 'MAIL': '/var/mail/cltbld', 14:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:40 INFO - 'MOZ_NO_REMOTE': '1', 14:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:40 INFO - 'NO_EM_RESTART': '1', 14:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:40 INFO - 'PWD': '/builds/slave/test', 14:49:40 INFO - 'SHELL': '/bin/bash', 14:49:40 INFO - 'SHLVL': '1', 14:49:40 INFO - 'TERM': 'linux', 14:49:40 INFO - 'TMOUT': '86400', 14:49:40 INFO - 'USER': 'cltbld', 14:49:40 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:40 INFO - '_': '/tools/buildbot/bin/python'} 14:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:49: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 14:49: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 14:49: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 14:49: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 14:49:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:49:41 INFO - Installing collected packages: mozsystemmonitor 14:49:41 INFO - Running setup.py install for mozsystemmonitor 14:49:41 INFO - Successfully installed mozsystemmonitor 14:49:41 INFO - Cleaning up... 14:49:41 INFO - Return code: 0 14:49:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:41 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:41 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 14:49:41 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 14:49:41 INFO - Using env: {'DISPLAY': ':0', 14:49:41 INFO - 'HOME': '/home/cltbld', 14:49:41 INFO - 'LANG': 'en_US.UTF-8', 14:49:41 INFO - 'LANGUAGE': 'en_US:en', 14:49:41 INFO - 'LOGNAME': 'cltbld', 14:49:41 INFO - 'MAIL': '/var/mail/cltbld', 14:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:41 INFO - 'MOZ_NO_REMOTE': '1', 14:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:41 INFO - 'NO_EM_RESTART': '1', 14:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:41 INFO - 'PWD': '/builds/slave/test', 14:49:41 INFO - 'SHELL': '/bin/bash', 14:49:41 INFO - 'SHLVL': '1', 14:49:41 INFO - 'TERM': 'linux', 14:49:41 INFO - 'TMOUT': '86400', 14:49:41 INFO - 'USER': 'cltbld', 14:49:41 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:41 INFO - '_': '/tools/buildbot/bin/python'} 14:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:49:42 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 14:49:42 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 14:49:42 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 14:49:42 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 14:49:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:49:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:49:43 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 14:49:43 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 14:49:43 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 14:49:43 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 14:49:43 INFO - Downloading functools32-3.2.3-2.tar.gz 14:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:49:43 INFO - warning: no files found matching '*.txt' 14:49:43 INFO - no previously-included directories found matching 'build' 14:49:43 INFO - no previously-included directories found matching 'dist' 14:49:43 INFO - no previously-included directories found matching '.git*' 14:49:43 INFO - Installing collected packages: jsonschema, functools32 14:49:43 INFO - Running setup.py install for functools32 14:49:43 INFO - warning: no files found matching '*.txt' 14:49:43 INFO - no previously-included directories found matching 'build' 14:49:43 INFO - no previously-included directories found matching 'dist' 14:49:43 INFO - no previously-included directories found matching '.git*' 14:49:43 INFO - Successfully installed jsonschema functools32 14:49:43 INFO - Cleaning up... 14:49:43 INFO - Return code: 0 14:49:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:49:43 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')]} 14:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:43 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')]} 14:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:43 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:43 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 14:49:43 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 14:49:43 INFO - Using env: {'DISPLAY': ':0', 14:49:43 INFO - 'HOME': '/home/cltbld', 14:49:43 INFO - 'LANG': 'en_US.UTF-8', 14:49:43 INFO - 'LANGUAGE': 'en_US:en', 14:49:43 INFO - 'LOGNAME': 'cltbld', 14:49:43 INFO - 'MAIL': '/var/mail/cltbld', 14:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:43 INFO - 'MOZ_NO_REMOTE': '1', 14:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:43 INFO - 'NO_EM_RESTART': '1', 14:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:43 INFO - 'PWD': '/builds/slave/test', 14:49:43 INFO - 'SHELL': '/bin/bash', 14:49:43 INFO - 'SHLVL': '1', 14:49:43 INFO - 'TERM': 'linux', 14:49:43 INFO - 'TMOUT': '86400', 14:49:43 INFO - 'USER': 'cltbld', 14:49:43 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:43 INFO - '_': '/tools/buildbot/bin/python'} 14:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:49:43 INFO - Cleaning up... 14:49:43 INFO - Return code: 0 14:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:49:43 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')]} 14:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:43 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')]} 14:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:43 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:43 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 14:49:43 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 14:49:43 INFO - Using env: {'DISPLAY': ':0', 14:49:43 INFO - 'HOME': '/home/cltbld', 14:49:43 INFO - 'LANG': 'en_US.UTF-8', 14:49:43 INFO - 'LANGUAGE': 'en_US:en', 14:49:43 INFO - 'LOGNAME': 'cltbld', 14:49:43 INFO - 'MAIL': '/var/mail/cltbld', 14:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:43 INFO - 'MOZ_NO_REMOTE': '1', 14:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:43 INFO - 'NO_EM_RESTART': '1', 14:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:43 INFO - 'PWD': '/builds/slave/test', 14:49:43 INFO - 'SHELL': '/bin/bash', 14:49:43 INFO - 'SHLVL': '1', 14:49:43 INFO - 'TERM': 'linux', 14:49:43 INFO - 'TMOUT': '86400', 14:49:43 INFO - 'USER': 'cltbld', 14:49:43 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:43 INFO - '_': '/tools/buildbot/bin/python'} 14:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:44 INFO - Downloading/unpacking blobuploader==1.2.4 14:49:44 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 14:49:44 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 14:49:44 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 14:49:44 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 14:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:49:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 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 14:49:45 INFO - Downloading docopt-0.6.1.tar.gz 14:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:49:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:49:45 INFO - Running setup.py install for blobuploader 14:49:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:49:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:49:45 INFO - Running setup.py install for requests 14:49:46 INFO - Running setup.py install for docopt 14:49:46 INFO - Successfully installed blobuploader requests docopt 14:49:46 INFO - Cleaning up... 14:49:46 INFO - Return code: 0 14:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:46 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')]} 14:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:46 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')]} 14:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:46 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:46 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 14:49:46 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 14:49:46 INFO - Using env: {'DISPLAY': ':0', 14:49:46 INFO - 'HOME': '/home/cltbld', 14:49:46 INFO - 'LANG': 'en_US.UTF-8', 14:49:46 INFO - 'LANGUAGE': 'en_US:en', 14:49:46 INFO - 'LOGNAME': 'cltbld', 14:49:46 INFO - 'MAIL': '/var/mail/cltbld', 14:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:46 INFO - 'MOZ_NO_REMOTE': '1', 14:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:46 INFO - 'NO_EM_RESTART': '1', 14:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:46 INFO - 'PWD': '/builds/slave/test', 14:49:46 INFO - 'SHELL': '/bin/bash', 14:49:46 INFO - 'SHLVL': '1', 14:49:46 INFO - 'TERM': 'linux', 14:49:46 INFO - 'TMOUT': '86400', 14:49:46 INFO - 'USER': 'cltbld', 14:49:46 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:46 INFO - '_': '/tools/buildbot/bin/python'} 14:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:46 INFO - Running setup.py (path:/tmp/pip-13_Hrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:46 INFO - Running setup.py (path:/tmp/pip-trgzks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:46 INFO - Running setup.py (path:/tmp/pip-2fJ_Ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:46 INFO - Running setup.py (path:/tmp/pip-4BYgx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:46 INFO - Running setup.py (path:/tmp/pip-pmRTQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:46 INFO - Running setup.py (path:/tmp/pip-846oLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:47 INFO - Running setup.py (path:/tmp/pip-jHrA4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:47 INFO - Running setup.py (path:/tmp/pip-Sz_AhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:47 INFO - Running setup.py (path:/tmp/pip-LfBlD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:47 INFO - Running setup.py (path:/tmp/pip-rC9xpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:47 INFO - Running setup.py (path:/tmp/pip-GV3Q2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:47 INFO - Running setup.py (path:/tmp/pip-9zdbcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:47 INFO - Running setup.py (path:/tmp/pip-p1NWjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:47 INFO - Running setup.py (path:/tmp/pip-SIlBhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:47 INFO - Running setup.py (path:/tmp/pip-GDg0Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:47 INFO - Running setup.py (path:/tmp/pip-8XNrtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:47 INFO - Running setup.py (path:/tmp/pip-8yTkts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:49:47 INFO - Running setup.py install for manifestparser 14:49:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:49:47 INFO - Running setup.py install for mozcrash 14:49:48 INFO - Running setup.py install for mozdebug 14:49:48 INFO - Running setup.py install for mozdevice 14:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozfile 14:49:48 INFO - Running setup.py install for mozhttpd 14:49:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozinfo 14:49:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozInstall 14:49:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozleak 14:49:48 INFO - Running setup.py install for mozlog 14:49:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for moznetwork 14:49:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:48 INFO - Running setup.py install for mozprocess 14:49:49 INFO - Running setup.py install for mozprofile 14:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozrunner 14:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Running setup.py install for mozscreenshot 14:49:49 INFO - Running setup.py install for moztest 14:49:49 INFO - Running setup.py install for mozversion 14:49:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:49 INFO - Cleaning up... 14:49:49 INFO - Return code: 0 14:49:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:49 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:49 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 14:49:49 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 14:49:49 INFO - Using env: {'DISPLAY': ':0', 14:49:49 INFO - 'HOME': '/home/cltbld', 14:49:49 INFO - 'LANG': 'en_US.UTF-8', 14:49:49 INFO - 'LANGUAGE': 'en_US:en', 14:49:49 INFO - 'LOGNAME': 'cltbld', 14:49:49 INFO - 'MAIL': '/var/mail/cltbld', 14:49:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:49 INFO - 'MOZ_NO_REMOTE': '1', 14:49:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:49 INFO - 'NO_EM_RESTART': '1', 14:49:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:49 INFO - 'PWD': '/builds/slave/test', 14:49:49 INFO - 'SHELL': '/bin/bash', 14:49:49 INFO - 'SHLVL': '1', 14:49:49 INFO - 'TERM': 'linux', 14:49:49 INFO - 'TMOUT': '86400', 14:49:49 INFO - 'USER': 'cltbld', 14:49:49 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:49 INFO - '_': '/tools/buildbot/bin/python'} 14:49:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:49 INFO - Running setup.py (path:/tmp/pip-va744r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:49 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)) 14:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:49 INFO - Running setup.py (path:/tmp/pip-wJ0aRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:49 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)) 14:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:49 INFO - Running setup.py (path:/tmp/pip-SD8LZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:50 INFO - Running setup.py (path:/tmp/pip-Z1_kqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:50 INFO - Running setup.py (path:/tmp/pip-1wikyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:50 INFO - Running setup.py (path:/tmp/pip-HkC5ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:50 INFO - Running setup.py (path:/tmp/pip-YnCLMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:50 INFO - Running setup.py (path:/tmp/pip-PdDZGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:50 INFO - Running setup.py (path:/tmp/pip-xsKxNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:50 INFO - Running setup.py (path:/tmp/pip-TNh5BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:50 INFO - Running setup.py (path:/tmp/pip-jMYTzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:50 INFO - Running setup.py (path:/tmp/pip-taCRgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:50 INFO - Running setup.py (path:/tmp/pip-PqMIEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:50 INFO - Running setup.py (path:/tmp/pip-nzvOPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:50 INFO - Running setup.py (path:/tmp/pip-gxjGug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:50 INFO - Running setup.py (path:/tmp/pip-kXDx0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:50 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)) 14:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:50 INFO - Running setup.py (path:/tmp/pip-govOXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 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)) 14:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:52 INFO - Downloading blessings-1.6.tar.gz 14:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:52 INFO - Installing collected packages: blessings 14:49:52 INFO - Running setup.py install for blessings 14:49:52 INFO - Successfully installed blessings 14:49:52 INFO - Cleaning up... 14:49:52 INFO - Return code: 0 14:49:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:52 INFO - Reading from file tmpfile_stdout 14:49:52 INFO - Current package versions: 14:49:52 INFO - argparse == 1.2.1 14:49:52 INFO - blessings == 1.6 14:49:52 INFO - blobuploader == 1.2.4 14:49:52 INFO - docopt == 0.6.1 14:49:52 INFO - functools32 == 3.2.3-2 14:49:52 INFO - jsonschema == 2.5.1 14:49:52 INFO - manifestparser == 1.1 14:49:52 INFO - mozInstall == 1.13 14:49:52 INFO - mozcrash == 1.0 14:49:52 INFO - mozdebug == 0.1 14:49:52 INFO - mozdevice == 0.51 14:49:52 INFO - mozfile == 1.2 14:49:52 INFO - mozhttpd == 0.7 14:49:52 INFO - mozinfo == 0.10 14:49:52 INFO - mozleak == 0.1 14:49:52 INFO - mozlog == 3.5 14:49:52 INFO - moznetwork == 0.27 14:49:52 INFO - mozprocess == 0.25 14:49:52 INFO - mozprofile == 0.28 14:49:52 INFO - mozrunner == 6.13 14:49:52 INFO - mozscreenshot == 0.1 14:49:52 INFO - mozsystemmonitor == 0.3 14:49:52 INFO - moztest == 0.8 14:49:52 INFO - mozversion == 1.4 14:49:52 INFO - psutil == 3.1.1 14:49:52 INFO - requests == 1.2.3 14:49:52 INFO - wsgiref == 0.1.2 14:49:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:52 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 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:52 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 14:49:52 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 14:49:52 INFO - Using env: {'DISPLAY': ':0', 14:49:52 INFO - 'HOME': '/home/cltbld', 14:49:52 INFO - 'LANG': 'en_US.UTF-8', 14:49:52 INFO - 'LANGUAGE': 'en_US:en', 14:49:52 INFO - 'LOGNAME': 'cltbld', 14:49:52 INFO - 'MAIL': '/var/mail/cltbld', 14:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:52 INFO - 'MOZ_NO_REMOTE': '1', 14:49:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:52 INFO - 'NO_EM_RESTART': '1', 14:49:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:52 INFO - 'PWD': '/builds/slave/test', 14:49:52 INFO - 'SHELL': '/bin/bash', 14:49:52 INFO - 'SHLVL': '1', 14:49:52 INFO - 'TERM': 'linux', 14:49:52 INFO - 'TMOUT': '86400', 14:49:52 INFO - 'USER': 'cltbld', 14:49:52 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:52 INFO - '_': '/tools/buildbot/bin/python'} 14:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 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)) 14:49:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:49:52 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 14:49:52 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 14:49:52 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 14:49:52 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 14:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:49:54 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)) 14:49:54 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)) 14:49:54 INFO - Installing collected packages: simplejson 14:49:54 INFO - Running setup.py install for simplejson 14:49:54 INFO - building 'simplejson._speedups' extension 14:49:54 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 14:49:54 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 14:49:55 INFO - Successfully installed simplejson 14:49:55 INFO - Cleaning up... 14:49:55 INFO - Return code: 0 14:49:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291dd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, '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': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', '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 14:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:49:55 INFO - Using env: {'DISPLAY': ':0', 14:49:55 INFO - 'HOME': '/home/cltbld', 14:49:55 INFO - 'LANG': 'en_US.UTF-8', 14:49:55 INFO - 'LANGUAGE': 'en_US:en', 14:49:55 INFO - 'LOGNAME': 'cltbld', 14:49:55 INFO - 'MAIL': '/var/mail/cltbld', 14:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:55 INFO - 'MOZ_NO_REMOTE': '1', 14:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:55 INFO - 'NO_EM_RESTART': '1', 14:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:55 INFO - 'PWD': '/builds/slave/test', 14:49:55 INFO - 'SHELL': '/bin/bash', 14:49:55 INFO - 'SHLVL': '1', 14:49:55 INFO - 'TERM': 'linux', 14:49:55 INFO - 'TMOUT': '86400', 14:49:55 INFO - 'USER': 'cltbld', 14:49:55 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:55 INFO - '_': '/tools/buildbot/bin/python'} 14:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:49:55 INFO - Cleaning up... 14:49:55 INFO - Return code: 0 14:49:55 INFO - Running post-action listener: _resource_record_post_action 14:49:55 INFO - Running post-action listener: _start_resource_monitoring 14:49:55 INFO - Starting resource monitoring. 14:49:55 INFO - [mozharness: 2017-08-08 21:49:55.311617Z] Finished create-virtualenv step (success) 14:49:55 INFO - [mozharness: 2017-08-08 21:49:55.312128Z] Running install step. 14:49:55 INFO - Running pre-action listener: _resource_record_pre_action 14:49:55 INFO - Running main action method: install 14:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:55 INFO - Reading from file tmpfile_stdout 14:49:55 INFO - Detecting whether we're running mozinstall >=1.0... 14:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:49:55 INFO - Reading from file tmpfile_stdout 14:49:55 INFO - Output received: 14:49:55 INFO - Usage: mozinstall [options] installer 14:49:55 INFO - Options: 14:49:55 INFO - -h, --help show this help message and exit 14:49:55 INFO - -d DEST, --destination=DEST 14:49:55 INFO - Directory to install application into. [default: 14:49:55 INFO - "/builds/slave/test"] 14:49:55 INFO - --app=APP Application being installed. [default: firefox] 14:49:55 INFO - mkdir: /builds/slave/test/build/application 14:49:55 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'] 14:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:50:13 INFO - Reading from file tmpfile_stdout 14:50:13 INFO - Output received: 14:50:13 INFO - /builds/slave/test/build/application/firefox/firefox 14:50:13 INFO - Running post-action listener: _resource_record_post_action 14:50:13 INFO - [mozharness: 2017-08-08 21:50:13.918259Z] Finished install step (success) 14:50:13 INFO - [mozharness: 2017-08-08 21:50:13.918513Z] Running setup-mitmproxy step. 14:50:13 INFO - Running pre-action listener: _resource_record_pre_action 14:50:13 INFO - Running main action method: setup_mitmproxy 14:50:13 INFO - Skipping: mitmproxy is not required 14:50:13 INFO - Running post-action listener: _resource_record_post_action 14:50:13 INFO - [mozharness: 2017-08-08 21:50:13.919661Z] Finished setup-mitmproxy step (success) 14:50:13 INFO - [mozharness: 2017-08-08 21:50:13.919883Z] Running run-tests step. 14:50:13 INFO - Running pre-action listener: _resource_record_pre_action 14:50:13 INFO - Running pre-action listener: _set_gcov_prefix 14:50:13 INFO - Running main action method: run_tests 14:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:50:13 INFO - Python 2.7.3 14:50:13 INFO - Return code: 0 14:50:13 INFO - grabbing minidump binary from tooltool 14:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:13 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 0x291aeb0>, '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 0x291bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291c240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:50:13 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 14:50:13 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 14:50:13 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 14:50:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:50:14 INFO - Return code: 0 14:50:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:50:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:50:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:50:14 INFO - ENV: RUST_BACKTRACE is now 1 14:50:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:50:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:50:14 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/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 14:50:14 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/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 14:50:14 INFO - Using env: {'DISPLAY': ':0', 14:50:14 INFO - 'HOME': '/home/cltbld', 14:50:14 INFO - 'LANG': 'en_US.UTF-8', 14:50:14 INFO - 'LANGUAGE': 'en_US:en', 14:50:14 INFO - 'LOGNAME': 'cltbld', 14:50:14 INFO - 'MAIL': '/var/mail/cltbld', 14:50:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:50:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:14 INFO - 'MOZ_NO_REMOTE': '1', 14:50:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:14 INFO - 'NO_EM_RESTART': '1', 14:50:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:14 INFO - 'PWD': '/builds/slave/test', 14:50:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:50:14 INFO - 'RUST_BACKTRACE': '1', 14:50:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:50:14 INFO - 'SHELL': '/bin/bash', 14:50:14 INFO - 'SHLVL': '1', 14:50:14 INFO - 'STYLO_FORCE_ENABLED': '1', 14:50:14 INFO - 'TERM': 'linux', 14:50:14 INFO - 'TMOUT': '86400', 14:50:14 INFO - 'USER': 'cltbld', 14:50:14 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335', 14:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:14 INFO - '_': '/tools/buildbot/bin/python'} 14:50:14 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/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 14:50:14 INFO - mozversion application_buildid: 20170808210507 14:50:14 INFO - mozversion application_changeset: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 14:50:14 INFO - mozversion application_display_name: Nightly 14:50:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:50:14 INFO - mozversion application_name: Firefox 14:50:14 INFO - mozversion application_remotingname: firefox 14:50:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:50:14 INFO - mozversion application_vendor: Mozilla 14:50:14 INFO - mozversion application_version: 57.0a1 14:50:14 INFO - mozversion platform_buildid: 20170808210507 14:50:14 INFO - mozversion platform_changeset: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 14:50:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:50:14 INFO - mozversion platform_version: 57.0a1 14:50:14 INFO - using testdate: 1502229014 14:50:14 INFO - actual date: 1502229014 14:50:14 INFO - starting webserver on 'localhost:44591' 14:50:14 INFO - SUITE-START | Running 2 tests 14:50:14 INFO - TEST-START | dromaeo_css 14:50:14 INFO - Initialising browser for dromaeo_css test... 14:50:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44591/getInfo.html -profile /tmp/tmpHwqaY7/profile 14:50:14 INFO - TEST-INFO | started process 28971 (/builds/slave/test/build/application/firefox/firefox http://localhost:44591/getInfo.html) 14:50:21 INFO - TEST-INFO | 28971: exit 0 14:50:21 INFO - Browser initialized. 14:50:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:50:21 INFO - TEST-INFO | started process 29199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHwqaY7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:22 INFO - PID 29199 | 14:50:22 INFO - PID 29199 | (/builds/slave/test/build/application/firefox/firefox:29253): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:50:22 INFO - PID 29199 | 14:50:32 INFO - PID 29199 | RSS: Main: 170504192 14:50:32 INFO - PID 29199 | 14:53:32 INFO - PID 29199 | Cycle 1(1): loaded http://localhost:44591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44591/tests/dromaeo/cssquery-ext.html) 14:53:33 INFO - PID 29199 | RSS: Main: 175513600 14:53:33 INFO - PID 29199 | 14:56:35 INFO - PID 29199 | Cycle 1(1): loaded http://localhost:44591/tests/dromaeo/cssquery-ext.html (next: http://localhost:44591/tests/dromaeo/cssquery-jquery.html) 14:56:35 INFO - PID 29199 | RSS: Main: 173756416 14:56:35 INFO - PID 29199 | 14:59:37 INFO - PID 29199 | Cycle 1(1): loaded http://localhost:44591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44591/tests/dromaeo/cssquery-mootools.html) 14:59:38 INFO - PID 29199 | RSS: Main: 175251456 14:59:38 INFO - PID 29199 | 15:02:40 INFO - PID 29199 | Cycle 1(1): loaded http://localhost:44591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44591/tests/dromaeo/cssquery-prototype.html) 15:02:40 INFO - PID 29199 | RSS: Main: 173305856 15:02:40 INFO - PID 29199 | 15:05:44 INFO - PID 29199 | Cycle 1(1): loaded http://localhost:44591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44591/tests/dromaeo/cssquery-yui.html) 15:05:45 INFO - PID 29199 | RSS: Main: 176525312 15:05:45 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | Cycle 1(1): loaded http://localhost:44591/tests/dromaeo/cssquery-yui.html (next: http://localhost:44591/tests/dromaeo/cssquery-dojo.html) 15:08:47 INFO - PID 29199 | RSS: Main: 177360896 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | __start_tp_report 15:08:47 INFO - PID 29199 | _x_x_mozilla_page_load 15:08:47 INFO - PID 29199 | _x_x_mozilla_page_load_details 15:08:47 INFO - PID 29199 | |i|pagename|runs| 15:08:47 INFO - PID 29199 | |0;dojo.html;3148.244421338878;3159.8262095584732;3187.8246696431715;3194.3930653175894;3215.083701145174;6151.538634602412;6199.504039676826;6219.222597175353;6245.875082498353;6257.624542527452;6057.39426057394;6184.81445556634;6185.288691800444;6220.688965551727;6243.625382477055;5565.972170139144;5614.6631202128;5643.548516118721;5649.830505084854;5660.716964151797;5680.801171958982;5681.11942648888;5723.399043100477;5744.339400968879;5766.394528574481;5666.206731057655;5666.886662266752;5758.625689330201;5759.5968282220265;5785.652860828342;850.9186295731546;5710.000749868798;5752.28096487939;5800.796972105956;5815.331236907768;5530.419305972855;5568.805091821807;5585.832425027255;5642.971785141089;5669.092945128801;5966.761329546813;6083;6193.907091393633;6195.721192546302;6200.224971878515;6585.5719378240265;6591.604503729744;6592.86814263712;6696.8995465068065;6699.263081061079;6649.60102393858;6665.800025999228;6758.898616520756;6759.459243260528;6780.593164410102;6027.78902738402;6124.724387402578;6181.134641150243;6198.535109866778;6244.500439964792;6721.798346049626;6777.322267773282;6935.791926242221;6951.026856240131;6954.7218111276;6479.44924681398;6536.823371793028;6582.012698095324;6585.967070164715;6596.604203747695;6611.305812889674;6620.073189753439;6720.630365329856;6727.192736871607;6729.461643068543;6562.442192413699;6581.374769396995;6675.599464032077;6692.631905245258;6693.364130407604;6418.454431373386;6492.09110724499;6501.837454063686;6539.2479864815205;6640.767573134917;5379.65032272901;5402.837914862561;5432.320959880015;5433.456654334614;5439.048166570834;4574.405327307429;4662.440507139165;4667.393238878924;4675;4684.110019096429;5775.913361299584;5843.29880414353;5848.590598658053;5851.853703657357;5852.297724273029;6685.331466853276;6689;6692.899606505906;6693.263740988487;6697.028930805006;5825;5831.854203644943;5838.649681019152;5894.557908156906;5899.203607513016;5891.587588868738;5899;5948.464638182584;5981.431763982415;5991.58058935879;6534.673266336664;6604.14146160996;6622.437092847162;6637.402633762985;6640.003999400129;6576.177977752781;6655.467562594884;6672.799816005528;6684;6799.218089919525;6538.967305163444;6545.770898018737;6546.279909210079;6562.704678289393;6565.638889861103;6508.349165083454;6518.413342799171;6597.901031484435;6602.8349291268105;6627.138471998609;6626.900596491153;6683.930571108599;6720.663966801738;6770.255271920183;6784.253732089367;6437.710303036468;6439.967800160969;6445.387688169616;6460.12788273577;6466.450351719968;6517.641529715911;6529.640869752019;6530.412262896362;6537.411632953057;6575.572587781779;6397.232332120176;6398.328175541687;6415.615063096229;6470.870582588416;6502.349765023649;6530.151080359523;6562.967185164043;6611.702473388806;6668.0331351954665;6677.09859169006;6218.06728990655;6316.905246421399;6328.588641738273;6406.743730250738;6410.326915673973 15:08:47 INFO - PID 29199 | |1;ext.html;821.1788211788212;862.3187681731432;882.2544949517659;887.5606574745502;1074.9731256718585;31388;32476.67523324769;43263.56736432635;44445;44622.55377446225;43105.35341969865;43575.12849743011;43647.56352436475;43667.12665746691;43684.56315436845;7820.139784623687;7844.058712954439;8056.758297251063;8060.677572897077;8063.032436107646;7887.645055972466;8013.919860801376;8019.67921283148;8025.598720064003;8030.116687164436;7980.960095199516;7994.600269986507;8011.95844540209;8053.154418786031;8053.838923221561;7941.404394670394;7966.800829979239;7974;7984.960075199587;8023;7808.141104478503;7845.646945887449;7901.1703771103785;7906.248906353887;7913.327367173797;39927.401088983686;40462.59537404647;40508.59491405107;40519;40531;3568.6074531801482;3614.1868079682126;3614.2771445710964;3616.168281295317;3618.077390265492;31473.685263147305;31912.840435797905;31969.360612787616;32079.03762887117;32156.356872862645;4921.630877684188;4931.753412329369;4948.257761335793;4959.8016079356785;4975.4527002029745;191100.9999999986;191151;191850;192068;193270;50358;50396;50442.747786260836;50522;50582.24126638103;53359.199612005854;53755.731221343645;53799.73100134474;53809.46190538123;53825;14154.504592339219;14392.784108238386;14503.419863205354;16574.83425165733;16787.412440564523;13508.189508629514;13642.181469111885;13654.93172534131;13694.452221911011;13716.314184290746;14927.328270227867;14935.103893766409;14995.550133496012;15117.470888518848;15200.619984500476;5832.912506312408;5973.223480947449;5998.700064996733;6064.696765161724;6105.694715264219;987.698662117265;1009.1926458832904;1016.0753714120262;1028.6296933104077;1037.056278786301;23046.501977371754;23325.416864578183;23706.644400334008;23799.04803807863;29797.553036704467;1084.3331351218944;1084.8698156221303;1090.2095980414294;1093.278436232083;1104.8397982292522;12627.494900204072;12637.620871373874;12670.176438531465;12706.618801435972;12714;228408;233052;234242;234799;235215;54423.72788136034;54725.45274547283;54995;55039.44960550423;55240.17139742907;1494.887883408727;1501.196859680066;1505.157112017274;1512;1517.9848201517843;23540.646890296317;23590.764092359543;23633.52732945366;23683.64474532849;23741.169059082848;38159;38332.04169895775;38491.23017539689;38532.80733596314;38675.226495470495;206703;207203;207513;207525;207712;34878.302433951685;36954.076148096516;39229;39438.605613944645;39562;46968.530314696414;49237;49566.50433495763;49823.25265121098;50133.49866501434;35701.46447803233;35758.64241357553;36196.4570531437;36197.81901090478;36604.450933235494;34956.65043349534;35495.29009419746;35524.467132993545;35587.28825423529;35875;37168.76987380766;38477.2304553913;38562;38611.42082868703;38681.2263754729;33880.66119338775;34122;34166.487502686985;34402;34429.827850861584;24386.756132438448;24515;24533.38666533351;25224.99100035978;25368.238952831445 15:08:47 INFO - PID 29199 | |2;jquery.html;586.1705686453669;593.1488314269025;593.9584229103963;599.313785715356;600.9699515024248;22903.770962290393;23762.40593985149;23769.5246095078;23780;23791.048358065676;21171.364859054214;21185.68221476679;22491.437714057156;24567.262982110522;27129.45741085177;6486.318936511658;6639.103720997652;6659.93340066598;6659.966700166492;6662.100616416795;5864.091065884794;6388.297287298416;6430.228372595295;6442.806715798533;6449.580777249487;6310.400511951358;6388.56257342099;6391.105245265667;6392.6484043377595;6393.232812062536;6322.462590679797;6375.2987171411105;6385.904211436832;6387.552871299011;6389.7763578275;5930.199423077873;5936.436038576328;5948.613340132921;5948.881022379572;5950.761969521214;29359.11922642324;30262.84868575665;30534.84732576345;30893.227669308224;31083.378332433225;1908.0841196225751;1937.9903100484548;1956.2566224834472;1961.08809403628;1964.882107073566;19278.71081933772;19707.704384434244;19834.80165198344;19894.602107957904;19920.402387928385;2394.365493144318;2400.939976500584;2414.420539070628;2449.6203088521306;2450.914218002379;122975.38512307381;128981.35509322488;134121;136611;139686.60313396837;15141.697166056618;15457.84542154564;15573.688526229638;15617;15922.442714504938;23847.880760596086;23854;23922.64116038261;23936.845683888532;24000.759992399853;10107.090361867467;10175.796484070277;10192.597923100768;10308.484575771181;10362.430066346273;9416.529173541296;9453.858192127123;9466.479343636029;9548.665796697222;9588.808223835484;9316.580753866092;9496.620135194653;9501.572429240701;9542.952285238529;9580.13778759915;2669.8398096114297;2677.839329640228;2718.904838330649;2779.7081306462933;2824.1207527677543;933.3559843707956;949.8670186173941;965.5461932891529;965.8599503072015;968.5254225429488;19447.416577502696;19615;19727.50681232952;20020;20247.987600620203;1009.6062535611118;1030.469308306223;1038.5482315192914;1041.1878734586883;1045.4772613693153;10568.101711354468;10776.29954052984;10778.568857245622;11003.559857605605;13114.409851556702;519095;519528;526077;552984;554162;122095.38952305181;122289.38855305666;124177;124549;127384;1221.108590728773;1271.9491220351083;1298.2924306252926;1299.2334522631693;1310.7444048410468;20836;21103.155873764877;21189.046492908165;21317.46706332292;21630.67553986723;57856.71071644615;58971.41028589659;59103;60517;61023;72212.63893680499;72343;72677.6366118166;72839.27160728326;73371;14687.706245875237;15323.846761532242;15349.769753453931;15374.154421506924;15427.5371738848;24339.75660243375;24349.26952191437;24413.38966525851;24439.633405499288;24453.38866528351;18992;19114.808851911304;19325.613487730447;19351.612967740846;19539.902300488975;15941.760873586674;16634.085125318223;17320.133993300537;17812.287508500034;17887.463376098738;18342.1746021432;19206.327778528244;19329.806701933365;19624.607507849476;19670.40988770339;15050.172240526439;15143.091414515164;15148.242587870342;15177.696446071237;15206.847931520542;18951.526211844815;19017.144228510027;19188.424347269603;19218;19285.517862053563 15:08:47 INFO - PID 29199 | |3;mootools.html;1364.8703373179549;1419.4747943260988;1426.728921504914;1433.319173392638;1442.567229831051;13843.377048032837;14494.42022319106;14553.126812391263;14566.27168641569;14575.562733117997;14306.7839233665;14656.193909334983;14656.853431465683;14747.631309217275;14779.556613301591;2472.344828620417;2546.2997675639162;2622.121589267588;2623.3048242215827;2627.6978147512996;2582.5480540905264;2600.3499125218696;2610.2691246451022;2614.816962812604;2619.2796980830235;2519.3323769201083;2525.3812815860047;2551.362159460135;2553.69355677319;2597.7921766258746;2498.2130628851855;2499.487605040962;2501.062101711858;2519.382751225943;2528.936776580582;2482.590372588521;2496.6504689343506;2505.8997640094376;2518.0431436054364;2519.710233323173;13793.724125517534;14084.15495070299;14142.080764750259;14145.575632731034;14164.57506274803;7562.508436951581;7775.222477752236;7818.06183258007;7842.333401660866;7857.724979625686;4912.582430493412;5071.594272458195;5167.586593072545;5169.405518365361;5195.896082078375;1789.2753434858903;1817.8091300413398;1821.1167583721885;1860.627874425107;1886.7264246684153;23183.76816231833;23242.070317187292;23247.883760581088;23259.88370058156;23299.18452854142;6589.83525411859;6992.3357281058215;7120.431312835781;7270;7317.304856038668;16122.516324510283;16214.67570648604;16215.756763648555;16219.432319868747;16230;7551.282628150317;7748.573828439377;7784.338331241908;7795.3373963212625;7809.219078092259;7094.53885497441;7176.354128128493;7198.172210195789;7228.31331023552;7321.048263725682;5112.463191364927;5223.791048358099;5242.685438873604;5250.789968401297;5283.445238250005;1550.9534713958599;1553.4718195813477;1566.7101586206588;1566.772817941392;1582.1456413536562;900.3517467423445;929.6327950459531;929.9814003720023;939.2392162348519;946.0775743650024;7499.400047996147;7505.549667019996;7552.6223688816435;7572.507786993828;7594.31651151399;712.127643636541;714.2928500784186;722.8518153778463;724.0948813982521;728.1262485017894;4699.201135806853;5705.828825135252;5808.477237048686;5816.243888294494;5898.587098903035;19021.239150433827;20199.59600808005;20216.29242976518;20258.392248232576;20299.28952486656;18909.52726181829;19546.31587894417;19765.110570024382;19825;20030.599388012448;10795;10938.890611093946;11117.666470005914;11120.388378639253;11129.109671226282;8131.443042013206;8333.624986875484;8744.387892847439;8775.385722999328;8862;16721.74917376216;17479.47561573155;17683.524306596828;17715.734263985792;18025.369112081014;17231.65536689234;17455.214515346586;17567.385141519986;17721.113944302477;17952.19215135296;11554.248973816675;11781.528738850693;11828.23116497425;11831.585894493996;11871.347075910908;12683.619491415273;13171.73656526845;13278.601641950758;13317.400716967953;13381.464741410235;10757.623483178051;10958.178136639624;11009.944950275198;11128.443577820915;11229.719257018312;10206.744831378977;10375.636852710119;10556.84164737545;10711.143108551141;10728.249022568345;9608.66369677058;9715.9028409715;9759.316847820584;9761.80476390454;9768.169705575106;7211.747588834365;7249;7268.563886166636;7282.67227974753;7356.301151390609;7348.375388092072;7423.925760742323;7498.32515073646;7520.586367749607;7555.659995300334 15:08:47 INFO - PID 29199 | |4;prototype.html;491.33424210195165;493.18378084270523;528.2920886012743;538.079883399387;541.4747694736105;6227.5017998560115;6237.937620623792;6311.779087731936;6321.810345689637;6365.29981702013;5948.821535353946;6101.694915254242;6105.938940610593;6132.601380910249;6171.783987560436;4903.926441103368;4919.631027672921;4928.482509336522;4939.160342741734;4941.45643979162;4922.661735675543;4959.57843583294;4977.352944117278;4983.401991760994;5003.499650034985;4812.855614331575;4828.782704778276;4932.408111026664;4964.429090654567;4971.801127954877;4946;4966.627502937258;4976.701397916137;4997.875053123701;5004.249362595603;4485.618722408566;4488.685791994561;4515.119551687422;4522.751248681321;4529.04889973106;6082.604630699035;6096.939030609681;6097.756089756404;6113.266408031065;6149.108379285023;5749.1663708762;5751.281089863767;5761.164631128505;5761.337446193699;5770.509506691937;6508.186476690414;6557.114789503404;6563.245226798931;6614.900776488356;6618.172728408949;4877.414710234794;4879.487064161959;4907.1657818171;4914.70511769295;4931.778069986859;6857.485688573327;6893.138357705287;6955.860882782316;6957.339052789976;6971.198312194061;5048.949510504922;5055.873603159876;5072.619553533426;5082;5084.288199652052;5121.436641969381;5121.487851214849;5121.692698438105;5123.769430375642;5133.537981581676;5693.68684722336;5703.494239550709;5718.571107166979;5719.685417302088;5747.3677895431465;6542.3130571290285;6563.737450501926;6571.474282057424;6596.406323430914;6623.370779775913;1678.4628918745884;1767.8320559546823;1771.9557011074826;1776.7740259221096;1778.208697129765;1173.4660729368118;1413.3427956000303;1454.7526920423554;1460.58373363593;1488.598078518794;5770.826875193751;5794.768209271582;5799.2750906136735;5800.88398232033;5845.853853653608;6536.738530458729;6612.2726500084955;6673.866522669519;6679.632620205838;6709.5303328767495;5752.798652047159;5760.596758226884;5791.913121303184;5798.739056742456;5872.706364681834;3539.2921415716446;3543.75193736436;3549.591796943333;3564.518789963374;3572.821358932095;6591.143151390289;6594.769183078569;6605.933940660628;6607.306232845578;6613.3056029117215;6882.69027893746;6887.690053947485;6928.653567321715;6959.791206263719;6993.580385176906;6472.9676351617;6557.245916719543;6591.077249185118;6638.369354911276;6651.33486651331;6574.539782215199;6708.127943367331;6734.427573656294;6759.155105611799;6819.965900170468;6579.638119903451;6614.503912206507;6712.731490740316;6722.294159113223;6747.561408508432;6389.456896163878;6539.182602174728;6579.572327798678;6611.438027767694;6612.735490580323;4943.456219815889;4990.326305948651;5074.5686616637995;5077.9238311424615;5083.669561478492;6697.3637504437;6753.898691519729;6772.356626120511;6866.759663411756;6870.106886104774;6509.837254068497;6535.248446428532;6583.111279977142;6623.172103487064;6645.169353830771;6471.158749362553;6524.739010439529;6538.476921846336;6548.8362790930605;6655.169828297257;6157.907631385622;6365.2361716594305;6409.903851442139;6447.129637498878;6492.675366231764;6220.813375598739;6547.770828020996;6555.853654880895;6600.537962342782;6642.634655093823;6337.968310158604;6356.872862542816;6389.562348471557;6437.420632143129;6446.8388290293115 15:08:47 INFO - PID 29199 | |5;yui.html;868.1101870582652;894.1907573645844;895.1898531828696;900.5272232078162;914.0722167000494;18412.539686507844;19487.317943871967;19497.902510487427;19548.511287217825;19566.804331956675;17208.13959302036;17215.22531486083;17774.377896773614;21662.89168554159;21687.783122168774;928.647114096644;944.2021491839384;947.6777895515523;951.4338968313876;951.6383774165841;955.1880901233965;992.6228033347318;995.1690338567305;996.008971073779;998.3810037776589;1038.2213339995003;1055.1189756553288;1057.4131357096808;1058.1006144776916;1058.3755584205317;1035.0012238190106;1035.03741520386;1036.3885307668475;1042.5517027678095;1042.8957104289586;774.9690012399498;783.7570353190529;785.1441928298183;785.7956931197873;786.504502163639;19622.70565941512;20200.797992020038;20459.795402045936;20490.282840100674;20669.276575319942;21692.891535542378;22073.227437039786;22251.887405629655;22353.441163970867;22368.217112400987;15756.684866302725;15817.446389376431;16232.513024609281;16350;16437.09595972221;3608.8736894208578;3624.818759062063;3646.4165733482514;3648.671619554253;3649.27014597079;126957.36521317427;130215.34892325668;130966;131832;133239;16684.082375469465;17178.828211717722;17237.39669111575;17311.65376692459;17375.131243437776;31386.843065784524;31549.36901261962;32169.51745723816;32193;32421.51367729486;8019.15798841125;8096.190380961974;8106.351491880635;8119.634616442274;8134.959325203336;4213.957860421357;4221.746695198237;4287.614114729689;4297.033167537342;4310.913781724348;5292.073887069748;5425.294711687456;5436.157395603688;5449.754761035763;5460.453954604587;934.7195841247599;972.5088830140734;983.2625530851861;987.0672214757129;989.8663680403054;656.2748163279507;686.7459040155175;688.18793823288;692.7402224165937;694.6040756768695;12849.807252891214;13371;13371.866281337258;13612.047156698936;13771.517996870061;659.9208095028628;677.2313424263398;710.137183322266;711.6263961420192;716.0476566166985;5147.227915812583;5306.734663266821;5327.627066105335;5389.380221274525;5472;102924;103176.48411757893;103478.48260758798;104293;105383.47308263562;89599;91170;94975;95265;95698;81211.18788812154;82438.76341854877;84447.5777621108;84837.57581212178;87745.56127219323;11873.346965916611;12482.687932801753;12484.93757531243;12496.625101246977;12642.810357844455;34973;35002.474962876084;35524.822375887954;35590.8220458896;36607.633923660425;63360.36639633545;63374.683126584074;63437.68281158565;64357.35642643514;65069.34930650633;18987.43037708871;19218.519537011685;19271.421857344303;19307.4207773767;20228.19087236494;21112.261070862445;21771.455713606654;21927.780722192572;22059.66910496312;22184.445388865406;17142.742858857375;17223.397181099102;17277.56806079858;17600.73598895992;17754;17911.462656120337;18536.44390668282;18576.164072616495;19001.144948477628;19208.807911920703;17245.396411125552;17249.482515524553;17433.30266789365;17483;18231;9066.863997040182;9313.953430233076;9721.076497732704;9725.610975560898;9774.218062555121;11953.402329883646;12093.939530302292;12154.75690486203;13187.010974176783;13476 15:08:47 INFO - PID 29199 | __end_tp_report 15:08:47 INFO - PID 29199 | __start_cc_report 15:08:47 INFO - PID 29199 | _x_x_mozilla_cycle_collect,362 15:08:47 INFO - PID 29199 | __end_cc_report 15:08:47 INFO - PID 29199 | __startTimestamp1502230127285__endTimestamp 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | ------- Summary: start ------- 15:08:47 INFO - PID 29199 | Number of tests: 6 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | [#0] dojo.html Cycles:165 Average:6116.08 Median:6418.45 stddev:827.51 (12.9%) stddev-sans-first:796.62 15:08:47 INFO - PID 29199 | Values: 3148.2 3159.8 3187.8 3194.4 3215.1 6151.5 6199.5 6219.2 6245.9 6257.6 6057.4 6184.8 6185.3 6220.7 6243.6 5566.0 5614.7 5643.5 5649.8 5660.7 5680.8 5681.1 5723.4 5744.3 5766.4 5666.2 5666.9 5758.6 5759.6 5785.7 850.9 5710.0 5752.3 5800.8 5815.3 5530.4 5568.8 5585.8 5643.0 5669.1 5966.8 6083.0 6193.9 6195.7 6200.2 6585.6 6591.6 6592.9 6696.9 6699.3 6649.6 6665.8 6758.9 6759.5 6780.6 6027.8 6124.7 6181.1 6198.5 6244.5 6721.8 6777.3 6935.8 6951.0 6954.7 6479.4 6536.8 6582.0 6586.0 6596.6 6611.3 6620.1 6720.6 6727.2 6729.5 6562.4 6581.4 6675.6 6692.6 6693.4 6418.5 6492.1 6501.8 6539.2 6640.8 5379.7 5402.8 5432.3 5433.5 5439.0 4574.4 4662.4 4667.4 4675.0 4684.1 5775.9 5843.3 5848.6 5851.9 5852.3 6685.3 6689.0 6692.9 6693.3 6697.0 5825.0 5831.9 5838.6 5894.6 5899.2 5891.6 5899.0 5948.5 5981.4 5991.6 6534.7 6604.1 6622.4 6637.4 6640.0 6576.2 6655.5 6672.8 6684.0 6799.2 6539.0 6545.8 6546.3 6562.7 6565.6 6508.3 6518.4 6597.9 6602.8 6627.1 6626.9 6683.9 6720.7 6770.3 6784.3 6437.7 6440.0 6445.4 6460.1 6466.5 6517.6 6529.6 6530.4 6537.4 6575.6 6397.2 6398.3 6415.6 6470.9 6502.3 6530.2 6563.0 6611.7 6668.0 6677.1 6218.1 6316.9 6328.6 6406.7 6410.3 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | [#1] ext.html Cycles:180 Average:39024.75 Median:36197.14 stddev:54784.22 (151.3%) stddev-sans-first:54862.80 15:08:47 INFO - PID 29199 | Values: 821.2 862.3 882.3 887.6 1075.0 31388.0 32476.7 43263.6 44445.0 44622.6 43105.4 43575.1 43647.6 43667.1 43684.6 7820.1 7844.1 8056.8 8060.7 8063.0 7887.6 8013.9 8019.7 8025.6 8030.1 7981.0 7994.6 8012.0 8053.2 8053.8 7941.4 7966.8 7974.0 7985.0 8023.0 7808.1 7845.6 7901.2 7906.2 7913.3 39927.4 40462.6 40508.6 40519.0 40531.0 3568.6 3614.2 3614.3 3616.2 3618.1 31473.7 31912.8 31969.4 32079.0 32156.4 4921.6 4931.8 4948.3 4959.8 4975.5 191101.0 191151.0 191850.0 192068.0 193270.0 50358.0 50396.0 50442.7 50522.0 50582.2 53359.2 53755.7 53799.7 53809.5 53825.0 14154.5 14392.8 14503.4 16574.8 16787.4 13508.2 13642.2 13654.9 13694.5 13716.3 14927.3 14935.1 14995.6 15117.5 15200.6 5832.9 5973.2 5998.7 6064.7 6105.7 987.7 1009.2 1016.1 1028.6 1037.1 23046.5 23325.4 23706.6 23799.0 29797.6 1084.3 1084.9 1090.2 1093.3 1104.8 12627.5 12637.6 12670.2 12706.6 12714.0 228408.0 233052.0 234242.0 234799.0 235215.0 54423.7 54725.5 54995.0 55039.4 55240.2 1494.9 1501.2 1505.2 1512.0 1518.0 23540.6 23590.8 23633.5 23683.6 23741.2 38159.0 38332.0 38491.2 38532.8 38675.2 206703.0 207203.0 207513.0 207525.0 207712.0 34878.3 36954.1 39229.0 39438.6 39562.0 46968.5 49237.0 49566.5 49823.3 50133.5 35701.5 35758.6 36196.5 36197.8 36604.5 34956.7 35495.3 35524.5 35587.3 35875.0 37168.8 38477.2 38562.0 38611.4 38681.2 33880.7 34122.0 34166.5 34402.0 34429.8 24386.8 24515.0 24533.4 25225.0 25368.2 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | [#2] jquery.html Cycles:180 Average:36479.25 Median:23774.76 stddev:89517.35 (376.5%) stddev-sans-first:89727.91 15:08:47 INFO - PID 29199 | Values: 586.2 593.1 594.0 599.3 601.0 22903.8 23762.4 23769.5 23780.0 23791.0 21171.4 21185.7 22491.4 24567.3 27129.5 6486.3 6639.1 6659.9 6660.0 6662.1 5864.1 6388.3 6430.2 6442.8 6449.6 6310.4 6388.6 6391.1 6392.6 6393.2 6322.5 6375.3 6385.9 6387.6 6389.8 5930.2 5936.4 5948.6 5948.9 5950.8 29359.1 30262.8 30534.8 30893.2 31083.4 1908.1 1938.0 1956.3 1961.1 1964.9 19278.7 19707.7 19834.8 19894.6 19920.4 2394.4 2400.9 2414.4 2449.6 2450.9 122975.4 128981.4 134121.0 136611.0 139686.6 15141.7 15457.8 15573.7 15617.0 15922.4 23847.9 23854.0 23922.6 23936.8 24000.8 10107.1 10175.8 10192.6 10308.5 10362.4 9416.5 9453.9 9466.5 9548.7 9588.8 9316.6 9496.6 9501.6 9543.0 9580.1 2669.8 2677.8 2718.9 2779.7 2824.1 933.4 949.9 965.5 965.9 968.5 19447.4 19615.0 19727.5 20020.0 20248.0 1009.6 1030.5 1038.5 1041.2 1045.5 10568.1 10776.3 10778.6 11003.6 13114.4 519095.0 519528.0 526077.0 552984.0 554162.0 122095.4 122289.4 124177.0 124549.0 127384.0 1221.1 1271.9 1298.3 1299.2 1310.7 20836.0 21103.2 21189.0 21317.5 21630.7 57856.7 58971.4 59103.0 60517.0 61023.0 72212.6 72343.0 72677.6 72839.3 73371.0 14687.7 15323.8 15349.8 15374.2 15427.5 24339.8 24349.3 24413.4 24439.6 24453.4 18992.0 19114.8 19325.6 19351.6 19539.9 15941.8 16634.1 17320.1 17812.3 17887.5 18342.2 19206.3 19329.8 19624.6 19670.4 15050.2 15143.1 15148.2 15177.7 15206.8 18951.5 19017.1 19188.4 19218.0 19285.5 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | [#3] mootools.html Cycles:180 Average:8895.62 Median:2503.48 stddev:6079.38 (242.8%) stddev-sans-first:6070.10 15:08:47 INFO - PID 29199 | Values: 1364.9 1419.5 1426.7 1433.3 1442.6 13843.4 14494.4 14553.1 14566.3 14575.6 14306.8 14656.2 14656.9 14747.6 14779.6 2472.3 2546.3 2622.1 2623.3 2627.7 2582.5 2600.3 2610.3 2614.8 2619.3 2519.3 2525.4 2551.4 2553.7 2597.8 2498.2 2499.5 2501.1 2519.4 2528.9 2482.6 2496.7 2505.9 2518.0 2519.7 13793.7 14084.2 14142.1 14145.6 14164.6 7562.5 7775.2 7818.1 7842.3 7857.7 4912.6 5071.6 5167.6 5169.4 5195.9 1789.3 1817.8 1821.1 1860.6 1886.7 23183.8 23242.1 23247.9 23259.9 23299.2 6589.8 6992.3 7120.4 7270.0 7317.3 16122.5 16214.7 16215.8 16219.4 16230.0 7551.3 7748.6 7784.3 7795.3 7809.2 7094.5 7176.4 7198.2 7228.3 7321.0 5112.5 5223.8 5242.7 5250.8 5283.4 1551.0 1553.5 1566.7 1566.8 1582.1 900.4 929.6 930.0 939.2 946.1 7499.4 7505.5 7552.6 7572.5 7594.3 712.1 714.3 722.9 724.1 728.1 4699.2 5705.8 5808.5 5816.2 5898.6 19021.2 20199.6 20216.3 20258.4 20299.3 18909.5 19546.3 19765.1 19825.0 20030.6 10795.0 10938.9 11117.7 11120.4 11129.1 8131.4 8333.6 8744.4 8775.4 8862.0 16721.7 17479.5 17683.5 17715.7 18025.4 17231.7 17455.2 17567.4 17721.1 17952.2 11554.2 11781.5 11828.2 11831.6 11871.3 12683.6 13171.7 13278.6 13317.4 13381.5 10757.6 10958.2 11009.9 11128.4 11229.7 10206.7 10375.6 10556.8 10711.1 10728.2 9608.7 9715.9 9759.3 9761.8 9768.2 7211.7 7249.0 7268.6 7282.7 7356.3 7348.4 7423.9 7498.3 7520.6 7555.7 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | [#4] prototype.html Cycles:180 Average:5532.87 Median:6109.60 stddev:1539.76 (25.2%) stddev-sans-first:1496.86 15:08:47 INFO - PID 29199 | Values: 491.3 493.2 528.3 538.1 541.5 6227.5 6237.9 6311.8 6321.8 6365.3 5948.8 6101.7 6105.9 6132.6 6171.8 4903.9 4919.6 4928.5 4939.2 4941.5 4922.7 4959.6 4977.4 4983.4 5003.5 4812.9 4828.8 4932.4 4964.4 4971.8 4946.0 4966.6 4976.7 4997.9 5004.2 4485.6 4488.7 4515.1 4522.8 4529.0 6082.6 6096.9 6097.8 6113.3 6149.1 5749.2 5751.3 5761.2 5761.3 5770.5 6508.2 6557.1 6563.2 6614.9 6618.2 4877.4 4879.5 4907.2 4914.7 4931.8 6857.5 6893.1 6955.9 6957.3 6971.2 5048.9 5055.9 5072.6 5082.0 5084.3 5121.4 5121.5 5121.7 5123.8 5133.5 5693.7 5703.5 5718.6 5719.7 5747.4 6542.3 6563.7 6571.5 6596.4 6623.4 1678.5 1767.8 1772.0 1776.8 1778.2 1173.5 1413.3 1454.8 1460.6 1488.6 5770.8 5794.8 5799.3 5800.9 5845.9 6536.7 6612.3 6673.9 6679.6 6709.5 5752.8 5760.6 5791.9 5798.7 5872.7 3539.3 3543.8 3549.6 3564.5 3572.8 6591.1 6594.8 6605.9 6607.3 6613.3 6882.7 6887.7 6928.7 6959.8 6993.6 6473.0 6557.2 6591.1 6638.4 6651.3 6574.5 6708.1 6734.4 6759.2 6820.0 6579.6 6614.5 6712.7 6722.3 6747.6 6389.5 6539.2 6579.6 6611.4 6612.7 4943.5 4990.3 5074.6 5077.9 5083.7 6697.4 6753.9 6772.4 6866.8 6870.1 6509.8 6535.2 6583.1 6623.2 6645.2 6471.2 6524.7 6538.5 6548.8 6655.2 6157.9 6365.2 6409.9 6447.1 6492.7 6220.8 6547.8 6555.9 6600.5 6642.6 6338.0 6356.9 6389.6 6437.4 6446.8 15:08:47 INFO - PID 29199 | 15:08:47 INFO - PID 29199 | [#5] yui.html Cycles:180 Average:23193.47 Median:31468.11 stddev:31454.00 (100.0%) stddev-sans-first:31497.57 15:08:47 INFO - PID 29199 | Values: 868.1 894.2 895.2 900.5 914.1 18412.5 19487.3 19497.9 19548.5 19566.8 17208.1 17215.2 17774.4 21662.9 21687.8 928.6 944.2 947.7 951.4 951.6 955.2 992.6 995.2 996.0 998.4 1038.2 1055.1 1057.4 1058.1 1058.4 1035.0 1035.0 1036.4 1042.6 1042.9 775.0 783.8 785.1 785.8 786.5 19622.7 20200.8 20459.8 20490.3 20669.3 21692.9 22073.2 22251.9 22353.4 22368.2 15756.7 15817.4 16232.5 16350.0 16437.1 3608.9 3624.8 3646.4 3648.7 3649.3 126957.4 130215.3 130966.0 131832.0 133239.0 16684.1 17178.8 17237.4 17311.7 17375.1 31386.8 31549.4 32169.5 32193.0 32421.5 8019.2 8096.2 8106.4 8119.6 8135.0 4214.0 4221.7 4287.6 4297.0 4310.9 5292.1 5425.3 5436.2 5449.8 5460.5 934.7 972.5 983.3 987.1 989.9 656.3 686.7 688.2 692.7 694.6 12849.8 13371.0 13371.9 13612.0 13771.5 659.9 677.2 710.1 711.6 716.0 5147.2 5306.7 5327.6 5389.4 5472.0 102924.0 103176.5 103478.5 104293.0 105383.5 89599.0 91170.0 94975.0 95265.0 95698.0 81211.2 82438.8 84447.6 84837.6 87745.6 11873.3 12482.7 12484.9 12496.6 12642.8 34973.0 35002.5 35524.8 35590.8 36607.6 63360.4 63374.7 63437.7 64357.4 65069.3 18987.4 19218.5 19271.4 19307.4 20228.2 21112.3 21771.5 21927.8 22059.7 22184.4 17142.7 17223.4 17277.6 17600.7 17754.0 17911.5 18536.4 18576.2 19001.1 19208.8 17245.4 17249.5 17433.3 17483.0 18231.0 9066.9 9314.0 9721.1 9725.6 9774.2 11953.4 12093.9 12154.8 13187.0 13476.0 15:08:47 INFO - PID 29199 | -------- Summary: end -------- 15:08:47 INFO - PID 29199 | 15:08:47 INFO - TEST-INFO | 29199: exit 0 15:08:48 INFO - TEST-OK | dromaeo_css | took 1113721ms 15:08:48 INFO - TEST-START | kraken 15:08:48 INFO - Initialising browser for kraken test... 15:08:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44591/getInfo.html -profile /tmp/tmpHjscI3/profile 15:08:48 INFO - TEST-INFO | started process 29577 (/builds/slave/test/build/application/firefox/firefox http://localhost:44591/getInfo.html) 15:08:54 INFO - TEST-INFO | 29577: exit 0 15:08:54 INFO - Browser initialized. 15:08:54 INFO - Running cycle 1/1 for kraken test... 15:08:54 INFO - TEST-INFO | started process 29808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjscI3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:55 INFO - PID 29808 | 15:08:55 INFO - PID 29808 | (/builds/slave/test/build/application/firefox/firefox:29863): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:08:55 INFO - PID 29808 | 15:09:05 INFO - PID 29808 | RSS: Main: 168599552 15:09:05 INFO - PID 29808 | 15:09:08 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44591/tests/kraken/driver.html?testName=audio-beat-detection) 15:09:09 INFO - PID 29808 | RSS: Main: 174084096 15:09:09 INFO - PID 29808 | 15:09:12 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44591/tests/kraken/driver.html?testName=audio-dft) 15:09:13 INFO - PID 29808 | RSS: Main: 174428160 15:09:13 INFO - PID 29808 | 15:09:16 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44591/tests/kraken/driver.html?testName=audio-fft) 15:09:16 INFO - PID 29808 | RSS: Main: 169336832 15:09:16 INFO - PID 29808 | 15:09:18 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44591/tests/kraken/driver.html?testName=audio-oscillator) 15:09:19 INFO - PID 29808 | RSS: Main: 170385408 15:09:19 INFO - PID 29808 | 15:09:21 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:09:22 INFO - PID 29808 | RSS: Main: 170139648 15:09:22 INFO - PID 29808 | 15:09:25 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44591/tests/kraken/driver.html?testName=imaging-darkroom) 15:09:26 INFO - PID 29808 | RSS: Main: 172703744 15:09:26 INFO - PID 29808 | 15:09:29 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44591/tests/kraken/driver.html?testName=imaging-desaturate) 15:09:30 INFO - PID 29808 | RSS: Main: 172703744 15:09:30 INFO - PID 29808 | 15:09:33 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44591/tests/kraken/driver.html?testName=json-parse-financial) 15:09:33 INFO - PID 29808 | RSS: Main: 173891584 15:09:33 INFO - PID 29808 | 15:09:35 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:09:36 INFO - PID 29808 | RSS: Main: 174149632 15:09:36 INFO - PID 29808 | 15:09:37 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:09:38 INFO - PID 29808 | RSS: Main: 173666304 15:09:38 INFO - PID 29808 | 15:09:40 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:09:41 INFO - PID 29808 | RSS: Main: 173826048 15:09:41 INFO - PID 29808 | 15:09:44 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:09:45 INFO - PID 29808 | RSS: Main: 174235648 15:09:45 INFO - PID 29808 | 15:09:48 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:09:48 INFO - PID 29808 | RSS: Main: 174100480 15:09:48 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | Cycle 1(1): loaded http://localhost:44591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44591/tests/kraken/driver.html?testName=ai-astar) 15:09:50 INFO - PID 29808 | RSS: Main: 175370240 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | __start_tp_report 15:09:50 INFO - PID 29808 | _x_x_mozilla_page_load 15:09:50 INFO - PID 29808 | _x_x_mozilla_page_load_details 15:09:50 INFO - PID 29808 | |i|pagename|runs| 15:09:50 INFO - PID 29808 | |0;ai-astar;98;108;102;108;108;113;107;100;112;108 15:09:50 INFO - PID 29808 | |1;audio-beat-detection;149;121;141;189;124;155;147;122;199;118 15:09:50 INFO - PID 29808 | |2;audio-dft;162;164;162;165;171;175;169;164;167;164 15:09:50 INFO - PID 29808 | |3;audio-fft;83;82;74;176;76;76;77;77;141;76 15:09:50 INFO - PID 29808 | |4;audio-oscillator;79;78;139;79;78;82;146;85;79;131 15:09:50 INFO - PID 29808 | |5;imaging-gaussian-blur;117;114;114;115;115;114;114;116;114;114 15:09:50 INFO - PID 29808 | |6;imaging-darkroom;150;152;150;152;150;150;149;150;152;150 15:09:50 INFO - PID 29808 | |7;imaging-desaturate;97;97;94;95;94;95;94;95;95;98 15:09:50 INFO - PID 29808 | |8;json-parse-financial;54;59;57;54;56;56;61;56;53;57 15:09:50 INFO - PID 29808 | |9;json-stringify-tinderbox;54;57;54;55;54;54;55;54;54;58 15:09:50 INFO - PID 29808 | |10;stanford-crypto-aes;88;81;79;99;89;86;78;83;87;79 15:09:50 INFO - PID 29808 | |11;stanford-crypto-ccm;139;142;136;131;125;153;132;140;133;169 15:09:50 INFO - PID 29808 | |12;stanford-crypto-pbkdf2;175;174;172;180;178;185;178;177;174;171 15:09:50 INFO - PID 29808 | |13;stanford-crypto-sha256-iterative;70;70;66;65;67;74;73;73;68;65 15:09:50 INFO - PID 29808 | __end_tp_report 15:09:50 INFO - PID 29808 | __start_cc_report 15:09:50 INFO - PID 29808 | _x_x_mozilla_cycle_collect,934 15:09:50 INFO - PID 29808 | __end_cc_report 15:09:50 INFO - PID 29808 | __startTimestamp1502230190977__endTimestamp 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | ------- Summary: start ------- 15:09:50 INFO - PID 29808 | Number of tests: 14 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#0] ai-astar Cycles:10 Average:106.40 Median:108.00 stddev:4.90 (4.5%) stddev-sans-first:4.15 15:09:50 INFO - PID 29808 | Values: 98.0 108.0 102.0 108.0 108.0 113.0 107.0 100.0 112.0 108.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#1] audio-beat-detection Cycles:10 Average:146.50 Median:148.00 stddev:28.36 (19.2%) stddev-sans-first:30.07 15:09:50 INFO - PID 29808 | Values: 149.0 121.0 141.0 189.0 124.0 155.0 147.0 122.0 199.0 118.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.00 stddev:4.22 (2.5%) stddev-sans-first:4.18 15:09:50 INFO - PID 29808 | Values: 162.0 164.0 162.0 165.0 171.0 175.0 169.0 164.0 167.0 164.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.50 stddev:35.19 (46.0%) stddev-sans-first:37.11 15:09:50 INFO - PID 29808 | Values: 83.0 82.0 74.0 176.0 76.0 76.0 77.0 77.0 141.0 76.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:79.00 stddev:28.64 (36.2%) stddev-sans-first:29.57 15:09:50 INFO - PID 29808 | Values: 79.0 78.0 139.0 79.0 78.0 82.0 146.0 85.0 79.0 131.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.06 (0.9%) stddev-sans-first:0.73 15:09:50 INFO - PID 29808 | Values: 117.0 114.0 114.0 115.0 115.0 114.0 114.0 116.0 114.0 114.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 15:09:50 INFO - PID 29808 | Values: 150.0 152.0 150.0 152.0 150.0 150.0 149.0 150.0 152.0 150.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.43 (1.5%) stddev-sans-first:1.39 15:09:50 INFO - PID 29808 | Values: 97.0 97.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 98.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:2.41 (4.3%) stddev-sans-first:2.40 15:09:50 INFO - PID 29808 | Values: 54.0 59.0 57.0 54.0 56.0 56.0 61.0 56.0 53.0 57.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:54.50 stddev:1.45 (2.7%) stddev-sans-first:1.50 15:09:50 INFO - PID 29808 | Values: 54.0 57.0 54.0 55.0 54.0 54.0 55.0 54.0 54.0 58.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:86.50 stddev:6.38 (7.4%) stddev-sans-first:6.67 15:09:50 INFO - PID 29808 | Values: 88.0 81.0 79.0 99.0 89.0 86.0 78.0 83.0 87.0 79.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:139.50 stddev:12.69 (9.1%) stddev-sans-first:13.46 15:09:50 INFO - PID 29808 | Values: 139.0 142.0 136.0 131.0 125.0 153.0 132.0 140.0 133.0 169.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:177.50 stddev:4.14 (2.3%) stddev-sans-first:4.36 15:09:50 INFO - PID 29808 | Values: 175.0 174.0 172.0 180.0 178.0 185.0 178.0 177.0 174.0 171.0 15:09:50 INFO - PID 29808 | 15:09:50 INFO - PID 29808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:3.41 (4.9%) stddev-sans-first:3.61 15:09:50 INFO - PID 29808 | Values: 70.0 70.0 66.0 65.0 67.0 74.0 73.0 73.0 68.0 65.0 15:09:50 INFO - PID 29808 | -------- Summary: end -------- 15:09:50 INFO - PID 29808 | 15:09:51 INFO - PID 29808 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:09:51 INFO - TEST-INFO | 29808: exit 0 15:09:51 INFO - TEST-OK | kraken | took 63688ms 15:09:51 INFO - SUITE-END | took 1177s 15:09:52 INFO - Completed test suite (00:19:37) 15:09:52 INFO - javascript benchmark 15:09:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8538.824765574323, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.244421338878, 3159.8262095584732, 3187.8246696431715, 3194.3930653175894, 3215.083701145174, 6151.538634602412, 6199.504039676826, 6219.222597175353, 6245.875082498353, 6257.624542527452, 6057.39426057394, 6184.81445556634, 6185.288691800444, 6220.688965551727, 6243.625382477055, 5565.972170139144, 5614.6631202128, 5643.548516118721, 5649.830505084854, 5660.716964151797, 5680.801171958982, 5681.11942648888, 5723.399043100477, 5744.339400968879, 5766.394528574481, 5666.206731057655, 5666.886662266752, 5758.625689330201, 5759.5968282220265, 5785.652860828342, 850.9186295731546, 5710.000749868798, 5752.28096487939, 5800.796972105956, 5815.331236907768, 5530.419305972855, 5568.805091821807, 5585.832425027255, 5642.971785141089, 5669.092945128801, 5966.761329546813, 6083.0, 6193.907091393633, 6195.721192546302, 6200.224971878515, 6585.5719378240265, 6591.604503729744, 6592.86814263712, 6696.8995465068065, 6699.263081061079, 6649.60102393858, 6665.800025999228, 6758.898616520756, 6759.459243260528, 6780.593164410102, 6027.78902738402, 6124.724387402578, 6181.134641150243, 6198.535109866778, 6244.500439964792, 6721.798346049626, 6777.322267773282, 6935.791926242221, 6951.026856240131, 6954.7218111276, 6479.44924681398, 6536.823371793028, 6582.012698095324, 6585.967070164715, 6596.604203747695, 6611.305812889674, 6620.073189753439, 6720.630365329856, 6727.192736871607, 6729.461643068543, 6562.442192413699, 6581.374769396995, 6675.599464032077, 6692.631905245258, 6693.364130407604, 6418.454431373386, 6492.09110724499, 6501.837454063686, 6539.2479864815205, 6640.767573134917, 5379.65032272901, 5402.837914862561, 5432.320959880015, 5433.456654334614, 5439.048166570834, 4574.405327307429, 4662.440507139165, 4667.393238878924, 4675.0, 4684.110019096429, 5775.913361299584, 5843.29880414353, 5848.590598658053, 5851.853703657357, 5852.297724273029, 6685.331466853276, 6689.0, 6692.899606505906, 6693.263740988487, 6697.028930805006, 5825.0, 5831.854203644943, 5838.649681019152, 5894.557908156906, 5899.203607513016, 5891.587588868738, 5899.0, 5948.464638182584, 5981.431763982415, 5991.58058935879, 6534.673266336664, 6604.14146160996, 6622.437092847162, 6637.402633762985, 6640.003999400129, 6576.177977752781, 6655.467562594884, 6672.799816005528, 6684.0, 6799.218089919525, 6538.967305163444, 6545.770898018737, 6546.279909210079, 6562.704678289393, 6565.638889861103, 6508.349165083454, 6518.413342799171, 6597.901031484435, 6602.8349291268105, 6627.138471998609, 6626.900596491153, 6683.930571108599, 6720.663966801738, 6770.255271920183, 6784.253732089367, 6437.710303036468, 6439.967800160969, 6445.387688169616, 6460.12788273577, 6466.450351719968, 6517.641529715911, 6529.640869752019, 6530.412262896362, 6537.411632953057, 6575.572587781779, 6397.232332120176, 6398.328175541687, 6415.615063096229, 6470.870582588416, 6502.349765023649, 6530.151080359523, 6562.967185164043, 6611.702473388806, 6668.0331351954665, 6677.09859169006, 6218.06728990655, 6316.905246421399, 6328.588641738273, 6406.743730250738, 6410.326915673973], "value": 6058.249401468133, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.1788211788212, 862.3187681731432, 882.2544949517659, 887.5606574745502, 1074.9731256718585, 31388.0, 32476.67523324769, 43263.56736432635, 44445.0, 44622.55377446225, 43105.35341969865, 43575.12849743011, 43647.56352436475, 43667.12665746691, 43684.56315436845, 7820.139784623687, 7844.058712954439, 8056.758297251063, 8060.677572897077, 8063.032436107646, 7887.645055972466, 8013.919860801376, 8019.67921283148, 8025.598720064003, 8030.116687164436, 7980.960095199516, 7994.600269986507, 8011.95844540209, 8053.154418786031, 8053.838923221561, 7941.404394670394, 7966.800829979239, 7974.0, 7984.960075199587, 8023.0, 7808.141104478503, 7845.646945887449, 7901.1703771103785, 7906.248906353887, 7913.327367173797, 39927.401088983686, 40462.59537404647, 40508.59491405107, 40519.0, 40531.0, 3568.6074531801482, 3614.1868079682126, 3614.2771445710964, 3616.168281295317, 3618.077390265492, 31473.685263147305, 31912.840435797905, 31969.360612787616, 32079.03762887117, 32156.356872862645, 4921.630877684188, 4931.753412329369, 4948.257761335793, 4959.8016079356785, 4975.4527002029745, 191100.9999999986, 191151.0, 191850.0, 192068.0, 193270.0, 50358.0, 50396.0, 50442.747786260836, 50522.0, 50582.24126638103, 53359.199612005854, 53755.731221343645, 53799.73100134474, 53809.46190538123, 53825.0, 14154.504592339219, 14392.784108238386, 14503.419863205354, 16574.83425165733, 16787.412440564523, 13508.189508629514, 13642.181469111885, 13654.93172534131, 13694.452221911011, 13716.314184290746, 14927.328270227867, 14935.103893766409, 14995.550133496012, 15117.470888518848, 15200.619984500476, 5832.912506312408, 5973.223480947449, 5998.700064996733, 6064.696765161724, 6105.694715264219, 987.698662117265, 1009.1926458832904, 1016.0753714120262, 1028.6296933104077, 1037.056278786301, 23046.501977371754, 23325.416864578183, 23706.644400334008, 23799.04803807863, 29797.553036704467, 1084.3331351218944, 1084.8698156221303, 1090.2095980414294, 1093.278436232083, 1104.8397982292522, 12627.494900204072, 12637.620871373874, 12670.176438531465, 12706.618801435972, 12714.0, 228408.0, 233052.0, 234242.0, 234799.0, 235215.0, 54423.72788136034, 54725.45274547283, 54995.0, 55039.44960550423, 55240.17139742907, 1494.887883408727, 1501.196859680066, 1505.157112017274, 1512.0, 1517.9848201517843, 23540.646890296317, 23590.764092359543, 23633.52732945366, 23683.64474532849, 23741.169059082848, 38159.0, 38332.04169895775, 38491.23017539689, 38532.80733596314, 38675.226495470495, 206703.0, 207203.0, 207513.0, 207525.0, 207712.0, 34878.302433951685, 36954.076148096516, 39229.0, 39438.605613944645, 39562.0, 46968.530314696414, 49237.0, 49566.50433495763, 49823.25265121098, 50133.49866501434, 35701.46447803233, 35758.64241357553, 36196.4570531437, 36197.81901090478, 36604.450933235494, 34956.65043349534, 35495.29009419746, 35524.467132993545, 35587.28825423529, 35875.0, 37168.76987380766, 38477.2304553913, 38562.0, 38611.42082868703, 38681.2263754729, 33880.66119338775, 34122.0, 34166.487502686985, 34402.0, 34429.827850861584, 24386.756132438448, 24515.0, 24533.38666533351, 25224.99100035978, 25368.238952831445], "value": 17829.55316867908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1705686453669, 593.1488314269025, 593.9584229103963, 599.313785715356, 600.9699515024248, 22903.770962290393, 23762.40593985149, 23769.5246095078, 23780.0, 23791.048358065676, 21171.364859054214, 21185.68221476679, 22491.437714057156, 24567.262982110522, 27129.45741085177, 6486.318936511658, 6639.103720997652, 6659.93340066598, 6659.966700166492, 6662.100616416795, 5864.091065884794, 6388.297287298416, 6430.228372595295, 6442.806715798533, 6449.580777249487, 6310.400511951358, 6388.56257342099, 6391.105245265667, 6392.6484043377595, 6393.232812062536, 6322.462590679797, 6375.2987171411105, 6385.904211436832, 6387.552871299011, 6389.7763578275, 5930.199423077873, 5936.436038576328, 5948.613340132921, 5948.881022379572, 5950.761969521214, 29359.11922642324, 30262.84868575665, 30534.84732576345, 30893.227669308224, 31083.378332433225, 1908.0841196225751, 1937.9903100484548, 1956.2566224834472, 1961.08809403628, 1964.882107073566, 19278.71081933772, 19707.704384434244, 19834.80165198344, 19894.602107957904, 19920.402387928385, 2394.365493144318, 2400.939976500584, 2414.420539070628, 2449.6203088521306, 2450.914218002379, 122975.38512307381, 128981.35509322488, 134121.0, 136611.0, 139686.60313396837, 15141.697166056618, 15457.84542154564, 15573.688526229638, 15617.0, 15922.442714504938, 23847.880760596086, 23854.0, 23922.64116038261, 23936.845683888532, 24000.759992399853, 10107.090361867467, 10175.796484070277, 10192.597923100768, 10308.484575771181, 10362.430066346273, 9416.529173541296, 9453.858192127123, 9466.479343636029, 9548.665796697222, 9588.808223835484, 9316.580753866092, 9496.620135194653, 9501.572429240701, 9542.952285238529, 9580.13778759915, 2669.8398096114297, 2677.839329640228, 2718.904838330649, 2779.7081306462933, 2824.1207527677543, 933.3559843707956, 949.8670186173941, 965.5461932891529, 965.8599503072015, 968.5254225429488, 19447.416577502696, 19615.0, 19727.50681232952, 20020.0, 20247.987600620203, 1009.6062535611118, 1030.469308306223, 1038.5482315192914, 1041.1878734586883, 1045.4772613693153, 10568.101711354468, 10776.29954052984, 10778.568857245622, 11003.559857605605, 13114.409851556702, 519095.0, 519528.0, 526077.0, 552984.0, 554162.0, 122095.38952305181, 122289.38855305666, 124177.0, 124549.0, 127384.0, 1221.108590728773, 1271.9491220351083, 1298.2924306252926, 1299.2334522631693, 1310.7444048410468, 20836.0, 21103.155873764877, 21189.046492908165, 21317.46706332292, 21630.67553986723, 57856.71071644615, 58971.41028589659, 59103.0, 60517.0, 61023.0, 72212.63893680499, 72343.0, 72677.6366118166, 72839.27160728326, 73371.0, 14687.706245875237, 15323.846761532242, 15349.769753453931, 15374.154421506924, 15427.5371738848, 24339.75660243375, 24349.26952191437, 24413.38966525851, 24439.633405499288, 24453.38866528351, 18992.0, 19114.808851911304, 19325.613487730447, 19351.612967740846, 19539.902300488975, 15941.760873586674, 16634.085125318223, 17320.133993300537, 17812.287508500034, 17887.463376098738, 18342.1746021432, 19206.327778528244, 19329.806701933365, 19624.607507849476, 19670.40988770339, 15050.172240526439, 15143.091414515164, 15148.242587870342, 15177.696446071237, 15206.847931520542, 18951.526211844815, 19017.144228510027, 19188.424347269603, 19218.0, 19285.517862053563], "value": 12220.352946587085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.8703373179549, 1419.4747943260988, 1426.728921504914, 1433.319173392638, 1442.567229831051, 13843.377048032837, 14494.42022319106, 14553.126812391263, 14566.27168641569, 14575.562733117997, 14306.7839233665, 14656.193909334983, 14656.853431465683, 14747.631309217275, 14779.556613301591, 2472.344828620417, 2546.2997675639162, 2622.121589267588, 2623.3048242215827, 2627.6978147512996, 2582.5480540905264, 2600.3499125218696, 2610.2691246451022, 2614.816962812604, 2619.2796980830235, 2519.3323769201083, 2525.3812815860047, 2551.362159460135, 2553.69355677319, 2597.7921766258746, 2498.2130628851855, 2499.487605040962, 2501.062101711858, 2519.382751225943, 2528.936776580582, 2482.590372588521, 2496.6504689343506, 2505.8997640094376, 2518.0431436054364, 2519.710233323173, 13793.724125517534, 14084.15495070299, 14142.080764750259, 14145.575632731034, 14164.57506274803, 7562.508436951581, 7775.222477752236, 7818.06183258007, 7842.333401660866, 7857.724979625686, 4912.582430493412, 5071.594272458195, 5167.586593072545, 5169.405518365361, 5195.896082078375, 1789.2753434858903, 1817.8091300413398, 1821.1167583721885, 1860.627874425107, 1886.7264246684153, 23183.76816231833, 23242.070317187292, 23247.883760581088, 23259.88370058156, 23299.18452854142, 6589.83525411859, 6992.3357281058215, 7120.431312835781, 7270.0, 7317.304856038668, 16122.516324510283, 16214.67570648604, 16215.756763648555, 16219.432319868747, 16230.0, 7551.282628150317, 7748.573828439377, 7784.338331241908, 7795.3373963212625, 7809.219078092259, 7094.53885497441, 7176.354128128493, 7198.172210195789, 7228.31331023552, 7321.048263725682, 5112.463191364927, 5223.791048358099, 5242.685438873604, 5250.789968401297, 5283.445238250005, 1550.9534713958599, 1553.4718195813477, 1566.7101586206588, 1566.772817941392, 1582.1456413536562, 900.3517467423445, 929.6327950459531, 929.9814003720023, 939.2392162348519, 946.0775743650024, 7499.400047996147, 7505.549667019996, 7552.6223688816435, 7572.507786993828, 7594.31651151399, 712.127643636541, 714.2928500784186, 722.8518153778463, 724.0948813982521, 728.1262485017894, 4699.201135806853, 5705.828825135252, 5808.477237048686, 5816.243888294494, 5898.587098903035, 19021.239150433827, 20199.59600808005, 20216.29242976518, 20258.392248232576, 20299.28952486656, 18909.52726181829, 19546.31587894417, 19765.110570024382, 19825.0, 20030.599388012448, 10795.0, 10938.890611093946, 11117.666470005914, 11120.388378639253, 11129.109671226282, 8131.443042013206, 8333.624986875484, 8744.387892847439, 8775.385722999328, 8862.0, 16721.74917376216, 17479.47561573155, 17683.524306596828, 17715.734263985792, 18025.369112081014, 17231.65536689234, 17455.214515346586, 17567.385141519986, 17721.113944302477, 17952.19215135296, 11554.248973816675, 11781.528738850693, 11828.23116497425, 11831.585894493996, 11871.347075910908, 12683.619491415273, 13171.73656526845, 13278.601641950758, 13317.400716967953, 13381.464741410235, 10757.623483178051, 10958.178136639624, 11009.944950275198, 11128.443577820915, 11229.719257018312, 10206.744831378977, 10375.636852710119, 10556.84164737545, 10711.143108551141, 10728.249022568345, 9608.66369677058, 9715.9028409715, 9759.316847820584, 9761.80476390454, 9768.169705575106, 7211.747588834365, 7249.0, 7268.563886166636, 7282.67227974753, 7356.301151390609, 7348.375388092072, 7423.925760742323, 7498.32515073646, 7520.586367749607, 7555.659995300334], "value": 6426.354583099264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.33424210195165, 493.18378084270523, 528.2920886012743, 538.079883399387, 541.4747694736105, 6227.5017998560115, 6237.937620623792, 6311.779087731936, 6321.810345689637, 6365.29981702013, 5948.821535353946, 6101.694915254242, 6105.938940610593, 6132.601380910249, 6171.783987560436, 4903.926441103368, 4919.631027672921, 4928.482509336522, 4939.160342741734, 4941.45643979162, 4922.661735675543, 4959.57843583294, 4977.352944117278, 4983.401991760994, 5003.499650034985, 4812.855614331575, 4828.782704778276, 4932.408111026664, 4964.429090654567, 4971.801127954877, 4946.0, 4966.627502937258, 4976.701397916137, 4997.875053123701, 5004.249362595603, 4485.618722408566, 4488.685791994561, 4515.119551687422, 4522.751248681321, 4529.04889973106, 6082.604630699035, 6096.939030609681, 6097.756089756404, 6113.266408031065, 6149.108379285023, 5749.1663708762, 5751.281089863767, 5761.164631128505, 5761.337446193699, 5770.509506691937, 6508.186476690414, 6557.114789503404, 6563.245226798931, 6614.900776488356, 6618.172728408949, 4877.414710234794, 4879.487064161959, 4907.1657818171, 4914.70511769295, 4931.778069986859, 6857.485688573327, 6893.138357705287, 6955.860882782316, 6957.339052789976, 6971.198312194061, 5048.949510504922, 5055.873603159876, 5072.619553533426, 5082.0, 5084.288199652052, 5121.436641969381, 5121.487851214849, 5121.692698438105, 5123.769430375642, 5133.537981581676, 5693.68684722336, 5703.494239550709, 5718.571107166979, 5719.685417302088, 5747.3677895431465, 6542.3130571290285, 6563.737450501926, 6571.474282057424, 6596.406323430914, 6623.370779775913, 1678.4628918745884, 1767.8320559546823, 1771.9557011074826, 1776.7740259221096, 1778.208697129765, 1173.4660729368118, 1413.3427956000303, 1454.7526920423554, 1460.58373363593, 1488.598078518794, 5770.826875193751, 5794.768209271582, 5799.2750906136735, 5800.88398232033, 5845.853853653608, 6536.738530458729, 6612.2726500084955, 6673.866522669519, 6679.632620205838, 6709.5303328767495, 5752.798652047159, 5760.596758226884, 5791.913121303184, 5798.739056742456, 5872.706364681834, 3539.2921415716446, 3543.75193736436, 3549.591796943333, 3564.518789963374, 3572.821358932095, 6591.143151390289, 6594.769183078569, 6605.933940660628, 6607.306232845578, 6613.3056029117215, 6882.69027893746, 6887.690053947485, 6928.653567321715, 6959.791206263719, 6993.580385176906, 6472.9676351617, 6557.245916719543, 6591.077249185118, 6638.369354911276, 6651.33486651331, 6574.539782215199, 6708.127943367331, 6734.427573656294, 6759.155105611799, 6819.965900170468, 6579.638119903451, 6614.503912206507, 6712.731490740316, 6722.294159113223, 6747.561408508432, 6389.456896163878, 6539.182602174728, 6579.572327798678, 6611.438027767694, 6612.735490580323, 4943.456219815889, 4990.326305948651, 5074.5686616637995, 5077.9238311424615, 5083.669561478492, 6697.3637504437, 6753.898691519729, 6772.356626120511, 6866.759663411756, 6870.106886104774, 6509.837254068497, 6535.248446428532, 6583.111279977142, 6623.172103487064, 6645.169353830771, 6471.158749362553, 6524.739010439529, 6538.476921846336, 6548.8362790930605, 6655.169828297257, 6157.907631385622, 6365.2361716594305, 6409.903851442139, 6447.129637498878, 6492.675366231764, 6220.813375598739, 6547.770828020996, 6555.853654880895, 6600.537962342782, 6642.634655093823, 6337.968310158604, 6356.872862542816, 6389.562348471557, 6437.420632143129, 6446.8388290293115], "value": 5090.214339363001, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [868.1101870582652, 894.1907573645844, 895.1898531828696, 900.5272232078162, 914.0722167000494, 18412.539686507844, 19487.317943871967, 19497.902510487427, 19548.511287217825, 19566.804331956675, 17208.13959302036, 17215.22531486083, 17774.377896773614, 21662.89168554159, 21687.783122168774, 928.647114096644, 944.2021491839384, 947.6777895515523, 951.4338968313876, 951.6383774165841, 955.1880901233965, 992.6228033347318, 995.1690338567305, 996.008971073779, 998.3810037776589, 1038.2213339995003, 1055.1189756553288, 1057.4131357096808, 1058.1006144776916, 1058.3755584205317, 1035.0012238190106, 1035.03741520386, 1036.3885307668475, 1042.5517027678095, 1042.8957104289586, 774.9690012399498, 783.7570353190529, 785.1441928298183, 785.7956931197873, 786.504502163639, 19622.70565941512, 20200.797992020038, 20459.795402045936, 20490.282840100674, 20669.276575319942, 21692.891535542378, 22073.227437039786, 22251.887405629655, 22353.441163970867, 22368.217112400987, 15756.684866302725, 15817.446389376431, 16232.513024609281, 16350.0, 16437.09595972221, 3608.8736894208578, 3624.818759062063, 3646.4165733482514, 3648.671619554253, 3649.27014597079, 126957.36521317427, 130215.34892325668, 130966.0, 131832.0, 133239.0, 16684.082375469465, 17178.828211717722, 17237.39669111575, 17311.65376692459, 17375.131243437776, 31386.843065784524, 31549.36901261962, 32169.51745723816, 32193.0, 32421.51367729486, 8019.15798841125, 8096.190380961974, 8106.351491880635, 8119.634616442274, 8134.959325203336, 4213.957860421357, 4221.746695198237, 4287.614114729689, 4297.033167537342, 4310.913781724348, 5292.073887069748, 5425.294711687456, 5436.157395603688, 5449.754761035763, 5460.453954604587, 934.7195841247599, 972.5088830140734, 983.2625530851861, 987.0672214757129, 989.8663680403054, 656.2748163279507, 686.7459040155175, 688.18793823288, 692.7402224165937, 694.6040756768695, 12849.807252891214, 13371.0, 13371.866281337258, 13612.047156698936, 13771.517996870061, 659.9208095028628, 677.2313424263398, 710.137183322266, 711.6263961420192, 716.0476566166985, 5147.227915812583, 5306.734663266821, 5327.627066105335, 5389.380221274525, 5472.0, 102924.0, 103176.48411757893, 103478.48260758798, 104293.0, 105383.47308263562, 89599.0, 91170.0, 94975.0, 95265.0, 95698.0, 81211.18788812154, 82438.76341854877, 84447.5777621108, 84837.57581212178, 87745.56127219323, 11873.346965916611, 12482.687932801753, 12484.93757531243, 12496.625101246977, 12642.810357844455, 34973.0, 35002.474962876084, 35524.822375887954, 35590.8220458896, 36607.633923660425, 63360.36639633545, 63374.683126584074, 63437.68281158565, 64357.35642643514, 65069.34930650633, 18987.43037708871, 19218.519537011685, 19271.421857344303, 19307.4207773767, 20228.19087236494, 21112.261070862445, 21771.455713606654, 21927.780722192572, 22059.66910496312, 22184.445388865406, 17142.742858857375, 17223.397181099102, 17277.56806079858, 17600.73598895992, 17754.0, 17911.462656120337, 18536.44390668282, 18576.164072616495, 19001.144948477628, 19208.807911920703, 17245.396411125552, 17249.482515524553, 17433.30266789365, 17483.0, 18231.0, 9066.863997040182, 9313.953430233076, 9721.076497732704, 9725.610975560898, 9774.218062555121, 11953.402329883646, 12093.939530302292, 12154.75690486203, 13187.010974176783, 13476.0], "value": 8976.123140365033, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 102.0, 108.0, 108.0, 113.0, 107.0, 100.0, 112.0, 108.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 141.0, 189.0, 124.0, 155.0, 147.0, 122.0, 199.0, 118.0], "value": 146.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 165.0, 171.0, 175.0, 169.0, 164.0, 167.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 74.0, 176.0, 76.0, 76.0, 77.0, 77.0, 141.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 139.0, 79.0, 78.0, 82.0, 146.0, 85.0, 79.0, 131.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0, 116.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 152.0, 150.0, 150.0, 149.0, 150.0, 152.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 98.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 57.0, 54.0, 56.0, 56.0, 61.0, 56.0, 53.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0, 58.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 79.0, 99.0, 89.0, 86.0, 78.0, 83.0, 87.0, 79.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 136.0, 131.0, 125.0, 153.0, 132.0, 140.0, 133.0, 169.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 172.0, 180.0, 178.0, 185.0, 178.0, 177.0, 174.0, 171.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 66.0, 65.0, 67.0, 74.0, 73.0, 73.0, 68.0, 65.0], "value": 69.1, "unit": "score"}]}]} 15:09:52 INFO - Return code: 0 15:09:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:09:52 INFO - # TBPL SUCCESS # 15:09:52 INFO - Running post-action listener: _package_coverage_data 15:09:52 INFO - Running post-action listener: _resource_record_post_action 15:09:52 INFO - [mozharness: 2017-08-08 22:09:52.251806Z] Finished run-tests step (success) 15:09:52 INFO - Running post-run listener: _resource_record_post_run 15:09:52 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 430243840; Read time: 0; Write time: 342032 15:09:52 INFO - TinderboxPrint: CPU usage
13.2% 15:09:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:09:52 INFO - TinderboxPrint: I/O write bytes / time
430,243,840 / 342,032 15:09:52 INFO - TinderboxPrint: CPU idle
8,277.5 (86.8%) 15:09:52 INFO - TinderboxPrint: CPU user
1,206.1 (12.6%) 15:09:52 INFO - TinderboxPrint: Swap in / out
0 / 0 15:09:52 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 106610688; Read time: 0; Write time: 104004 15:09:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:09:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 322510848; Read time: 0; Write time: 237980 15:09:52 INFO - Running post-run listener: _upload_blobber_files 15:09:52 INFO - Blob upload gear active. 15:09:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:09:52 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 15:09:52 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'] 15:09:52 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 15:09:53 INFO - (blobuploader) - INFO - Open directory for files ... 15:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:00 INFO - (blobuploader) - INFO - Done attempting. 15:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:00 INFO - (blobuploader) - INFO - Done attempting. 15:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:01 INFO - (blobuploader) - INFO - Done attempting. 15:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:02 INFO - (blobuploader) - INFO - Done attempting. 15:10:02 INFO - (blobuploader) - INFO - Iteration through files over. 15:10:02 INFO - Return code: 0 15:10:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:10:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:10:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5a65602007f0bf7a752f5f5869b175eb72eeb65a1ade9e4c72e6d21b687ca5fb373ee50e4f7a23e8895ceb4d9d3e70c94e33fe7f8d6dd69a44deae258c67e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0309b1adcbef4c5fe03c93a0d5cc4221b9643af1529899a1563fb0494dc994c0abe00e6f84ac016a88d33da1125998494930094a79d72367eb27913aab03c09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e26901753f019bde0e2a67e4c8440ca489ab9410e2051359951fb5034d13c7934a746c0c3c3f87b127605f53da9e81b8c7844352f1afdda1e52b95af54973fc4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c523c82b6daf8e1e67722581eda6de995bd461b2cbe03d78574648a75e0c2428a9b4a59776e21864470133a511cc66012f27e5bc3f6770e0c133a2ac0d0050"} 15:10:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:10:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:10:02 INFO - Contents: 15:10:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5a65602007f0bf7a752f5f5869b175eb72eeb65a1ade9e4c72e6d21b687ca5fb373ee50e4f7a23e8895ceb4d9d3e70c94e33fe7f8d6dd69a44deae258c67e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0309b1adcbef4c5fe03c93a0d5cc4221b9643af1529899a1563fb0494dc994c0abe00e6f84ac016a88d33da1125998494930094a79d72367eb27913aab03c09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e26901753f019bde0e2a67e4c8440ca489ab9410e2051359951fb5034d13c7934a746c0c3c3f87b127605f53da9e81b8c7844352f1afdda1e52b95af54973fc4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c523c82b6daf8e1e67722581eda6de995bd461b2cbe03d78574648a75e0c2428a9b4a59776e21864470133a511cc66012f27e5bc3f6770e0c133a2ac0d0050"} 15:10:02 INFO - Running post-run listener: copy_logs_to_upload_dir 15:10:02 INFO - Copying logs to upload dir... 15:10:02 INFO - mkdir: /builds/slave/test/build/upload/logs 15:10:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.744602 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-08 15:10:02.190226) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:10:02.197736) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335 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/9a5a65602007f0bf7a752f5f5869b175eb72eeb65a1ade9e4c72e6d21b687ca5fb373ee50e4f7a23e8895ceb4d9d3e70c94e33fe7f8d6dd69a44deae258c67e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0309b1adcbef4c5fe03c93a0d5cc4221b9643af1529899a1563fb0494dc994c0abe00e6f84ac016a88d33da1125998494930094a79d72367eb27913aab03c09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e26901753f019bde0e2a67e4c8440ca489ab9410e2051359951fb5034d13c7934a746c0c3c3f87b127605f53da9e81b8c7844352f1afdda1e52b95af54973fc4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c523c82b6daf8e1e67722581eda6de995bd461b2cbe03d78574648a75e0c2428a9b4a59776e21864470133a511cc66012f27e5bc3f6770e0c133a2ac0d0050"} build_url:https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5a65602007f0bf7a752f5f5869b175eb72eeb65a1ade9e4c72e6d21b687ca5fb373ee50e4f7a23e8895ceb4d9d3e70c94e33fe7f8d6dd69a44deae258c67e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0309b1adcbef4c5fe03c93a0d5cc4221b9643af1529899a1563fb0494dc994c0abe00e6f84ac016a88d33da1125998494930094a79d72367eb27913aab03c09f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e26901753f019bde0e2a67e4c8440ca489ab9410e2051359951fb5034d13c7934a746c0c3c3f87b127605f53da9e81b8c7844352f1afdda1e52b95af54973fc4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61c523c82b6daf8e1e67722581eda6de995bd461b2cbe03d78574648a75e0c2428a9b4a59776e21864470133a511cc66012f27e5bc3f6770e0c133a2ac0d0050"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:10:02.225903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:10:02.226319) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1502226318.723038-2051304335 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:10:02.312144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:10:02.312748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:10:02.313418) ========= ========= Total master_lag: 0.27 =========