builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1500225591.55 results: success (0) revision: 5f44d10bacca2d693413b529e0caadc73e634e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.551668) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.552161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.552497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.601339) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.601761) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 10:19:51-- 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% 67.2M=0s 2017-07-16 10:19:51 (67.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.782307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.782677) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017995 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.835766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:51.836148) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f44d10bacca2d693413b529e0caadc73e634e1e --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 5f44d10bacca2d693413b529e0caadc73e634e1e --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=82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 10:19:51,927 truncating revision to first 12 chars 2017-07-16 10:19:51,927 Setting DEBUG logging. 2017-07-16 10:19:51,927 attempt 1/10 2017-07-16 10:19:51,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f44d10bacca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 10:19:52,412 unpacking tar archive at: mozilla-central-5f44d10bacca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.807076 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.655871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.656219) ========= script_repo_revision: 5f44d10bacca2d693413b529e0caadc73e634e1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.656648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.656952) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.664631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-16 10:19:52.665018) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:19:52 INFO - MultiFileLogger online at 20170716 10:19:52 in /builds/slave/test 10:19:52 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 10:19:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:19:52 INFO - {'append_to_log': False, 10:19:52 INFO - 'base_work_dir': '/builds/slave/test', 10:19:52 INFO - 'blob_upload_branch': 'Firefox', 10:19:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:19:52 INFO - 'branch': 'Firefox', 10:19:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:19:52 INFO - 'code_coverage': False, 10:19:52 INFO - 'config_files': ('talos/linux_config.py',), 10:19:52 INFO - 'default_actions': ('clobber', 10:19:52 INFO - 'read-buildbot-config', 10:19:52 INFO - 'download-and-extract', 10:19:52 INFO - 'populate-webroot', 10:19:52 INFO - 'create-virtualenv', 10:19:52 INFO - 'install', 10:19:52 INFO - 'setup-mitmproxy', 10:19:52 INFO - 'run-tests'), 10:19:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:19:52 INFO - 'disable_ccov_upload': False, 10:19:52 INFO - 'download_minidump_stackwalk': True, 10:19:52 INFO - 'download_symbols': 'ondemand', 10:19:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:19:52 INFO - 'tooltool.py': '/tools/tooltool.py', 10:19:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:19:52 INFO - '/tools/misc-python/virtualenv.py')}, 10:19:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:19:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:19:52 INFO - 'gecko_profile': False, 10:19:52 INFO - 'gecko_profile_interval': 0, 10:19:52 INFO - 'installer_path': 'installer.exe', 10:19:52 INFO - 'log_level': 'info', 10:19:52 INFO - 'log_name': 'talos', 10:19:52 INFO - 'log_to_console': True, 10:19:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:19:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:19:52 INFO - 'opt_config_files': (), 10:19:52 INFO - 'pip_index': False, 10:19:52 INFO - 'suite': 'dromaeojs-e10s', 10:19:52 INFO - 'system_bits': '32', 10:19:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:19:52 INFO - 'title': 'talos-linux64-ix-066', 10:19:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:19:52 INFO - 'use_talos_json': True, 10:19:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:19:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:19:52 INFO - 'work_dir': 'build'} 10:19:52 INFO - [mozharness: 2017-07-16 17:19:52.950822Z] Running clobber step. 10:19:52 INFO - Running pre-action listener: _resource_record_pre_action 10:19:52 INFO - Running main action method: clobber 10:19:52 INFO - rmtree: /builds/slave/test/build 10:19:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:19:53 INFO - Running post-action listener: _resource_record_post_action 10:19:53 INFO - [mozharness: 2017-07-16 17:19:53.941035Z] Finished clobber step (success) 10:19:53 INFO - [mozharness: 2017-07-16 17:19:53.941138Z] Running read-buildbot-config step. 10:19:53 INFO - Running pre-action listener: _resource_record_pre_action 10:19:53 INFO - Running main action method: read_buildbot_config 10:19:53 INFO - Using buildbot properties: 10:19:53 INFO - { 10:19:53 INFO - "project": "", 10:19:53 INFO - "product": "firefox", 10:19:53 INFO - "who": "ffxbld@noreply.mozilla.org", 10:19:53 INFO - "installer_path": "public/build/target.tar.bz2", 10:19:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:19:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:19:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:19:53 INFO - "stage_platform": "linux64-pgo", 10:19:53 INFO - "basedir": "/builds/slave/test", 10:19:53 INFO - "buildnumber": 71, 10:19:53 INFO - "platform": "ubuntu64_hw", 10:19:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:19:53 INFO - "slavebuilddir": "test", 10:19:53 INFO - "taskId": "fo6n-MEeQbqrnhmZ80rN8g", 10:19:53 INFO - "branch": "mozilla-central", 10:19:53 INFO - "script_repo_revision": "production", 10:19:53 INFO - "revision": "5f44d10bacca2d693413b529e0caadc73e634e1e", 10:19:53 INFO - "slavename": "talos-linux64-ix-066", 10:19:53 INFO - "repo_path": "mozilla-central" 10:19:53 INFO - } 10:19:53 INFO - Finding installer, test and symbols from parent task. 10:19:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fo6n-MEeQbqrnhmZ80rN8g'}, attempt #1 10:19:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fo6n-MEeQbqrnhmZ80rN8g'}, attempt #1 10:19:54 INFO - Task dependencies: KSq8SEQpR5iD7VvyeLx3VA 10:19:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA'}, attempt #1 10:19:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2 10:19:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/test_packages.json 10:19:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.crashreporter-symbols.zip 10:19:55 INFO - Running post-action listener: _resource_record_post_action 10:19:55 INFO - [mozharness: 2017-07-16 17:19:55.299813Z] Finished read-buildbot-config step (success) 10:19:55 INFO - [mozharness: 2017-07-16 17:19:55.300034Z] Running download-and-extract step. 10:19:55 INFO - Running pre-action listener: _resource_record_pre_action 10:19:55 INFO - Running main action method: download_and_extract 10:19:55 INFO - mkdir: /builds/slave/test/build/tests 10:19: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')]} 10:19:55 INFO - trying https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.test_packages.json 10:19:55 INFO - Downloading https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:19:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:19:55 INFO - Downloaded 989 bytes. 10:19:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:19:55 INFO - Using the following test package requirements: 10:19:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:19:55 INFO - u'common': [u'target.common.tests.zip'], 10:19:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:19:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:19:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:19:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:19:55 INFO - u'mozbase': [u'target.common.tests.zip'], 10:19:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:19:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:19:55 INFO - u'web-platform': [u'target.common.tests.zip', 10:19:55 INFO - u'target.web-platform.tests.tar.gz'], 10:19:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:19:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:19:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.common.tests.zip 10:19:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:19:55 INFO - Fetch https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.common.tests.zip into memory 10:19:57 INFO - Content-Length response header: 73365523 10:19:57 INFO - Bytes received: 73365523 10:20:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:20:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.common.tests.zip 10:20:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:20:08 INFO - Fetch https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.common.tests.zip into memory 10:20:10 INFO - Content-Length response header: 73365523 10:20:10 INFO - Bytes received: 73365523 10:20:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.talos.tests.zip 10:20:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:20:23 INFO - Fetch https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.talos.tests.zip into memory 10:20:24 INFO - Content-Length response header: 14495033 10:20:24 INFO - Bytes received: 14495033 10:20:24 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')]} 10:20:24 INFO - trying https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2 10:20:24 INFO - Downloading https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:20:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:20:26 INFO - Downloaded 62653502 bytes. 10:20:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2 10:20:26 INFO - mkdir: /builds/slave/test/properties 10:20:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:20:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:20:26 INFO - Contents: 10:20:26 INFO - build_url:https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2 10:20:26 INFO - Running post-action listener: _resource_record_post_action 10:20:26 INFO - Running post-action listener: set_extra_try_arguments 10:20:26 INFO - [mozharness: 2017-07-16 17:20:26.207618Z] Finished download-and-extract step (success) 10:20:26 INFO - [mozharness: 2017-07-16 17:20:26.207845Z] Running populate-webroot step. 10:20:26 INFO - Running pre-action listener: _resource_record_pre_action 10:20:26 INFO - Running main action method: populate_webroot 10:20:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:20:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:20:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:20:26 INFO - '--tppagecycles', 10:20:26 INFO - '7'], 10:20:26 INFO - 'tests': ['tsvgm']}}, 10:20:26 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:20:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:20:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:20:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['damp', 'tps']}, 10:20:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'tests': ['damp', 'tps']}, 10:20:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['dromaeo_dom']}, 10:20:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:20:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:20:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:20:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:20:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['a11yr', 10:20:26 INFO - 'ts_paint', 10:20:26 INFO - 'tpaint', 10:20:26 INFO - 'sessionrestore', 10:20:26 INFO - 'sessionrestore_no_auto_restore', 10:20:26 INFO - 'tabpaint']}, 10:20:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:20:26 INFO - 'ts_paint', 10:20:26 INFO - 'tpaint', 10:20:26 INFO - 'sessionrestore', 10:20:26 INFO - 'sessionrestore_many_windows', 10:20:26 INFO - 'sessionrestore_no_auto_restore', 10:20:26 INFO - 'tabpaint']}, 10:20:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:20:26 INFO - 'ts_paint', 10:20:26 INFO - 'tpaint', 10:20:26 INFO - 'sessionrestore', 10:20:26 INFO - 'sessionrestore_many_windows', 10:20:26 INFO - 'sessionrestore_no_auto_restore', 10:20:26 INFO - 'tabpaint']}, 10:20:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:20:26 INFO - 'ts_paint', 10:20:26 INFO - 'tpaint', 10:20:26 INFO - 'sessionrestore', 10:20:26 INFO - 'sessionrestore_many_windows', 10:20:26 INFO - 'sessionrestore_no_auto_restore', 10:20:26 INFO - 'tabpaint']}, 10:20:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['a11yr', 10:20:26 INFO - 'ts_paint', 10:20:26 INFO - 'tpaint', 10:20:26 INFO - 'sessionrestore', 10:20:26 INFO - 'sessionrestore_no_auto_restore', 10:20:26 INFO - 'tabpaint']}, 10:20:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['a11yr', 10:20:26 INFO - 'ts_paint', 10:20:26 INFO - 'tpaint', 10:20:26 INFO - 'sessionrestore', 10:20:26 INFO - 'sessionrestore_no_auto_restore', 10:20:26 INFO - 'tabpaint']}, 10:20:26 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 10:20:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:20:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:20:26 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:20:26 INFO - 'talos_options': ['--mitmproxy', 10:20:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:20:26 INFO - '--firstNonBlankPaint'], 10:20:26 INFO - 'tests': ['quantum_pageload_google', 10:20:26 INFO - 'quantum_pageload_youtube', 10:20:26 INFO - 'quantum_pageload_amazon', 10:20:26 INFO - 'quantum_pageload_facebook']}, 10:20:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['tsvgx', 10:20:26 INFO - 'tsvgr_opacity', 10:20:26 INFO - 'tart', 10:20:26 INFO - 'tscrollx', 10:20:26 INFO - 'cart', 10:20:26 INFO - 'tsvg_static']}, 10:20:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:20:26 INFO - 'tsvgr_opacity', 10:20:26 INFO - 'tart', 10:20:26 INFO - 'tscrollx', 10:20:26 INFO - 'cart', 10:20:26 INFO - 'tsvg_static']}, 10:20:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'talos_options': ['--disable-e10s'], 10:20:26 INFO - 'tests': ['tp5o']}, 10:20:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:20:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'talos_options': ['--disable-e10s', 10:20:26 INFO - '--xperf_path', 10:20:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:26 INFO - 'tests': ['tp5n']}, 10:20:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:20:26 INFO - 'talos_options': ['--xperf_path', 10:20:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:26 INFO - 'tests': ['tp5n']}}, 10:20:26 INFO - 'talos.zip': {'path': '', 10:20:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:20:26 INFO - Running post-action listener: _resource_record_post_action 10:20:26 INFO - [mozharness: 2017-07-16 17:20:26.224986Z] Finished populate-webroot step (success) 10:20:26 INFO - [mozharness: 2017-07-16 17:20:26.225076Z] Running create-virtualenv step. 10:20:26 INFO - Running pre-action listener: _resource_record_pre_action 10:20:26 INFO - Running main action method: create_virtualenv 10:20:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:20:26 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 10:20:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:20:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:20:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:20:26 INFO - Using real prefix '/usr' 10:20:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:20:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:20:28 INFO - Installing pip.................done. 10:20:28 INFO - Return code: 0 10:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:20:29 INFO - Reading from file tmpfile_stdout 10:20:29 INFO - Output received: 10:20:29 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) 10:20:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:29 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:29 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 10:20:29 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 10:20:29 INFO - Using env: {'DISPLAY': ':0', 10:20:29 INFO - 'HOME': '/home/cltbld', 10:20:29 INFO - 'LANG': 'en_US.UTF-8', 10:20:29 INFO - 'LANGUAGE': 'en_US:en', 10:20:29 INFO - 'LOGNAME': 'cltbld', 10:20:29 INFO - 'MAIL': '/var/mail/cltbld', 10:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:29 INFO - 'MOZ_NO_REMOTE': '1', 10:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:29 INFO - 'NO_EM_RESTART': '1', 10:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:29 INFO - 'PWD': '/builds/slave/test', 10:20:29 INFO - 'SHELL': '/bin/bash', 10:20:29 INFO - 'SHLVL': '1', 10:20:29 INFO - 'TERM': 'linux', 10:20:29 INFO - 'TMOUT': '86400', 10:20:29 INFO - 'USER': 'cltbld', 10:20:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:29 INFO - '_': '/tools/buildbot/bin/python'} 10:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:29 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 10:20:29 INFO - Cleaning up... 10:20:29 INFO - Return code: 0 10:20:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:29 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:29 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 10:20:29 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 10:20:29 INFO - Using env: {'DISPLAY': ':0', 10:20:29 INFO - 'HOME': '/home/cltbld', 10:20:29 INFO - 'LANG': 'en_US.UTF-8', 10:20:29 INFO - 'LANGUAGE': 'en_US:en', 10:20:29 INFO - 'LOGNAME': 'cltbld', 10:20:29 INFO - 'MAIL': '/var/mail/cltbld', 10:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:29 INFO - 'MOZ_NO_REMOTE': '1', 10:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:29 INFO - 'NO_EM_RESTART': '1', 10:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:29 INFO - 'PWD': '/builds/slave/test', 10:20:29 INFO - 'SHELL': '/bin/bash', 10:20:29 INFO - 'SHLVL': '1', 10:20:29 INFO - 'TERM': 'linux', 10:20:29 INFO - 'TMOUT': '86400', 10:20:29 INFO - 'USER': 'cltbld', 10:20:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:29 INFO - '_': '/tools/buildbot/bin/python'} 10:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:29 INFO - Downloading/unpacking psutil>=3.1.1 10:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:20:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:30 INFO - Installing collected packages: psutil 10:20:30 INFO - Running setup.py install for psutil 10:20:30 INFO - building 'psutil._psutil_linux' extension 10:20:30 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 10:20:32 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 10:20:32 INFO - building 'psutil._psutil_posix' extension 10:20:32 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 10:20:32 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 10:20:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:32 INFO - Successfully installed psutil 10:20:32 INFO - Cleaning up... 10:20:32 INFO - Return code: 0 10:20:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:20:32 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')]} 10:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:32 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')]} 10:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:20:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:20:32 INFO - Using env: {'DISPLAY': ':0', 10:20:32 INFO - 'HOME': '/home/cltbld', 10:20:32 INFO - 'LANG': 'en_US.UTF-8', 10:20:32 INFO - 'LANGUAGE': 'en_US:en', 10:20:32 INFO - 'LOGNAME': 'cltbld', 10:20:32 INFO - 'MAIL': '/var/mail/cltbld', 10:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:32 INFO - 'MOZ_NO_REMOTE': '1', 10:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:32 INFO - 'NO_EM_RESTART': '1', 10:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:32 INFO - 'PWD': '/builds/slave/test', 10:20:32 INFO - 'SHELL': '/bin/bash', 10:20:32 INFO - 'SHLVL': '1', 10:20:32 INFO - 'TERM': 'linux', 10:20:32 INFO - 'TMOUT': '86400', 10:20:32 INFO - 'USER': 'cltbld', 10:20:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:32 INFO - '_': '/tools/buildbot/bin/python'} 10:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:20:32 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 10:20:32 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 10:20:32 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 10:20:32 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 10:20:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:20:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:20:33 INFO - Installing collected packages: mozsystemmonitor 10:20:33 INFO - Running setup.py install for mozsystemmonitor 10:20:33 INFO - Successfully installed mozsystemmonitor 10:20:33 INFO - Cleaning up... 10:20:34 INFO - Return code: 0 10:20:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20: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')]} 10:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:34 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:34 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 10:20:34 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 10:20:34 INFO - Using env: {'DISPLAY': ':0', 10:20:34 INFO - 'HOME': '/home/cltbld', 10:20:34 INFO - 'LANG': 'en_US.UTF-8', 10:20:34 INFO - 'LANGUAGE': 'en_US:en', 10:20:34 INFO - 'LOGNAME': 'cltbld', 10:20:34 INFO - 'MAIL': '/var/mail/cltbld', 10:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:34 INFO - 'MOZ_NO_REMOTE': '1', 10:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:34 INFO - 'NO_EM_RESTART': '1', 10:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:34 INFO - 'PWD': '/builds/slave/test', 10:20:34 INFO - 'SHELL': '/bin/bash', 10:20:34 INFO - 'SHLVL': '1', 10:20:34 INFO - 'TERM': 'linux', 10:20:34 INFO - 'TMOUT': '86400', 10:20:34 INFO - 'USER': 'cltbld', 10:20:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:34 INFO - '_': '/tools/buildbot/bin/python'} 10:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:20:34 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 10:20:34 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 10:20:34 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 10:20:34 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 10:20:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:35 INFO - Downloading functools32-3.2.3-2.tar.gz 10:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:20:35 INFO - warning: no files found matching '*.txt' 10:20:35 INFO - no previously-included directories found matching 'build' 10:20:35 INFO - no previously-included directories found matching 'dist' 10:20:35 INFO - no previously-included directories found matching '.git*' 10:20:35 INFO - Installing collected packages: jsonschema, functools32 10:20:35 INFO - Running setup.py install for functools32 10:20:35 INFO - warning: no files found matching '*.txt' 10:20:35 INFO - no previously-included directories found matching 'build' 10:20:35 INFO - no previously-included directories found matching 'dist' 10:20:35 INFO - no previously-included directories found matching '.git*' 10:20:35 INFO - Successfully installed jsonschema functools32 10:20:35 INFO - Cleaning up... 10:20:35 INFO - Return code: 0 10:20:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:20:35 INFO - Using env: {'DISPLAY': ':0', 10:20:35 INFO - 'HOME': '/home/cltbld', 10:20:35 INFO - 'LANG': 'en_US.UTF-8', 10:20:35 INFO - 'LANGUAGE': 'en_US:en', 10:20:35 INFO - 'LOGNAME': 'cltbld', 10:20:35 INFO - 'MAIL': '/var/mail/cltbld', 10:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:35 INFO - 'MOZ_NO_REMOTE': '1', 10:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:35 INFO - 'NO_EM_RESTART': '1', 10:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:35 INFO - 'PWD': '/builds/slave/test', 10:20:35 INFO - 'SHELL': '/bin/bash', 10:20:35 INFO - 'SHLVL': '1', 10:20:35 INFO - 'TERM': 'linux', 10:20:35 INFO - 'TMOUT': '86400', 10:20:35 INFO - 'USER': 'cltbld', 10:20:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:35 INFO - '_': '/tools/buildbot/bin/python'} 10:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:20:35 INFO - Cleaning up... 10:20:35 INFO - Return code: 0 10:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:20:35 INFO - Using env: {'DISPLAY': ':0', 10:20:35 INFO - 'HOME': '/home/cltbld', 10:20:35 INFO - 'LANG': 'en_US.UTF-8', 10:20:35 INFO - 'LANGUAGE': 'en_US:en', 10:20:35 INFO - 'LOGNAME': 'cltbld', 10:20:35 INFO - 'MAIL': '/var/mail/cltbld', 10:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:35 INFO - 'MOZ_NO_REMOTE': '1', 10:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:35 INFO - 'NO_EM_RESTART': '1', 10:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:35 INFO - 'PWD': '/builds/slave/test', 10:20:35 INFO - 'SHELL': '/bin/bash', 10:20:35 INFO - 'SHLVL': '1', 10:20:35 INFO - 'TERM': 'linux', 10:20:35 INFO - 'TMOUT': '86400', 10:20:35 INFO - 'USER': 'cltbld', 10:20:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:35 INFO - '_': '/tools/buildbot/bin/python'} 10:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:20:36 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 10:20:36 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 10:20:36 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 10:20:36 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 10:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 10:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:20:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:37 INFO - Downloading docopt-0.6.1.tar.gz 10:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:20:37 INFO - Installing collected packages: blobuploader, requests, docopt 10:20:37 INFO - Running setup.py install for blobuploader 10:20:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:20:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:20:37 INFO - Running setup.py install for requests 10:20:38 INFO - Running setup.py install for docopt 10:20:38 INFO - Successfully installed blobuploader requests docopt 10:20:38 INFO - Cleaning up... 10:20:38 INFO - Return code: 0 10:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20: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')]} 10:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:38 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:38 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 10:20:38 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 10:20:38 INFO - Using env: {'DISPLAY': ':0', 10:20:38 INFO - 'HOME': '/home/cltbld', 10:20:38 INFO - 'LANG': 'en_US.UTF-8', 10:20:38 INFO - 'LANGUAGE': 'en_US:en', 10:20:38 INFO - 'LOGNAME': 'cltbld', 10:20:38 INFO - 'MAIL': '/var/mail/cltbld', 10:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:38 INFO - 'MOZ_NO_REMOTE': '1', 10:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:38 INFO - 'NO_EM_RESTART': '1', 10:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:38 INFO - 'PWD': '/builds/slave/test', 10:20:38 INFO - 'SHELL': '/bin/bash', 10:20:38 INFO - 'SHLVL': '1', 10:20:38 INFO - 'TERM': 'linux', 10:20:38 INFO - 'TMOUT': '86400', 10:20:38 INFO - 'USER': 'cltbld', 10:20:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:38 INFO - '_': '/tools/buildbot/bin/python'} 10:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:38 INFO - Running setup.py (path:/tmp/pip-c_Ni4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:38 INFO - Running setup.py (path:/tmp/pip-YF1TS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:38 INFO - Running setup.py (path:/tmp/pip-5qPwN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:38 INFO - Running setup.py (path:/tmp/pip-AIJ_LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:38 INFO - Running setup.py (path:/tmp/pip-eZ84i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:38 INFO - Running setup.py (path:/tmp/pip-uGjMBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:39 INFO - Running setup.py (path:/tmp/pip-2vhFjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:39 INFO - Running setup.py (path:/tmp/pip-u8IC0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:39 INFO - Running setup.py (path:/tmp/pip-v79yYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:39 INFO - Running setup.py (path:/tmp/pip-LfyGZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:39 INFO - Running setup.py (path:/tmp/pip-laZPqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:39 INFO - Running setup.py (path:/tmp/pip-mguioQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:39 INFO - Running setup.py (path:/tmp/pip-6rLTmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:39 INFO - Running setup.py (path:/tmp/pip-dvlDYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:39 INFO - Running setup.py (path:/tmp/pip-GLcJx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:39 INFO - Running setup.py (path:/tmp/pip-AASwAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:39 INFO - Running setup.py (path:/tmp/pip-XFHaSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:20:39 INFO - Running setup.py install for manifestparser 10:20:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:20:39 INFO - Running setup.py install for mozcrash 10:20:40 INFO - Running setup.py install for mozdebug 10:20:40 INFO - Running setup.py install for mozdevice 10:20:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Running setup.py install for mozfile 10:20:40 INFO - Running setup.py install for mozhttpd 10:20:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Running setup.py install for mozinfo 10:20:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Running setup.py install for mozInstall 10:20:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Running setup.py install for mozleak 10:20:40 INFO - Running setup.py install for mozlog 10:20:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Running setup.py install for moznetwork 10:20:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:20:40 INFO - Running setup.py install for mozprocess 10:20:41 INFO - Running setup.py install for mozprofile 10:20:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:20:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:20:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:20:41 INFO - Running setup.py install for mozrunner 10:20:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:20:41 INFO - Running setup.py install for mozscreenshot 10:20:41 INFO - Running setup.py install for moztest 10:20:41 INFO - Running setup.py install for mozversion 10:20:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:20:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:20:41 INFO - Cleaning up... 10:20:41 INFO - Return code: 0 10:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20: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')]} 10:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20: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')]} 10:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:41 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:41 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 10:20:41 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 10:20:41 INFO - Using env: {'DISPLAY': ':0', 10:20:41 INFO - 'HOME': '/home/cltbld', 10:20:41 INFO - 'LANG': 'en_US.UTF-8', 10:20:41 INFO - 'LANGUAGE': 'en_US:en', 10:20:41 INFO - 'LOGNAME': 'cltbld', 10:20:41 INFO - 'MAIL': '/var/mail/cltbld', 10:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:41 INFO - 'MOZ_NO_REMOTE': '1', 10:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:41 INFO - 'NO_EM_RESTART': '1', 10:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:41 INFO - 'PWD': '/builds/slave/test', 10:20:41 INFO - 'SHELL': '/bin/bash', 10:20:41 INFO - 'SHLVL': '1', 10:20:41 INFO - 'TERM': 'linux', 10:20:41 INFO - 'TMOUT': '86400', 10:20:41 INFO - 'USER': 'cltbld', 10:20:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:41 INFO - '_': '/tools/buildbot/bin/python'} 10:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:20:41 INFO - Running setup.py (path:/tmp/pip-BK7amK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:20:41 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)) 10:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:20:41 INFO - Running setup.py (path:/tmp/pip-U0dpAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:20:41 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)) 10:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:20:41 INFO - Running setup.py (path:/tmp/pip-bqW2qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:20:42 INFO - Running setup.py (path:/tmp/pip-MhQcCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:20:42 INFO - Running setup.py (path:/tmp/pip-MBrqWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:20:42 INFO - Running setup.py (path:/tmp/pip-L7Y1B3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:20:42 INFO - Running setup.py (path:/tmp/pip-4V_T93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:20:42 INFO - Running setup.py (path:/tmp/pip-SmG86y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:20:42 INFO - Running setup.py (path:/tmp/pip-3eY2s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:20:42 INFO - Running setup.py (path:/tmp/pip-aSfVWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:20:42 INFO - Running setup.py (path:/tmp/pip-oAtiX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:20:42 INFO - Running setup.py (path:/tmp/pip-pcDbYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:20:42 INFO - Running setup.py (path:/tmp/pip-M1wcbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:20:42 INFO - Running setup.py (path:/tmp/pip-CnfNi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:42 INFO - Running setup.py (path:/tmp/pip-26DXei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:20:42 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)) 10:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:20:42 INFO - Running setup.py (path:/tmp/pip-LH2Ndt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:20:43 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)) 10:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:20:43 INFO - Running setup.py (path:/tmp/pip-H6VX0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:20:43 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)) 10:20:43 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)) 10:20:43 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)) 10:20:43 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)) 10:20:43 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)) 10:20:43 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)) 10:20:43 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)) 10:20:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:20: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 10:20: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 10:20: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 10:20: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 10:20:44 INFO - Downloading blessings-1.6.tar.gz 10:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:20:44 INFO - Installing collected packages: blessings 10:20:44 INFO - Running setup.py install for blessings 10:20:44 INFO - Successfully installed blessings 10:20:44 INFO - Cleaning up... 10:20:44 INFO - Return code: 0 10:20:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:20:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:44 INFO - Reading from file tmpfile_stdout 10:20:44 INFO - Current package versions: 10:20:44 INFO - argparse == 1.2.1 10:20:44 INFO - blessings == 1.6 10:20:44 INFO - blobuploader == 1.2.4 10:20:44 INFO - docopt == 0.6.1 10:20:44 INFO - functools32 == 3.2.3-2 10:20:44 INFO - jsonschema == 2.5.1 10:20:44 INFO - manifestparser == 1.1 10:20:44 INFO - mozInstall == 1.13 10:20:44 INFO - mozcrash == 1.0 10:20:44 INFO - mozdebug == 0.1 10:20:44 INFO - mozdevice == 0.51 10:20:44 INFO - mozfile == 1.2 10:20:44 INFO - mozhttpd == 0.7 10:20:44 INFO - mozinfo == 0.10 10:20:44 INFO - mozleak == 0.1 10:20:44 INFO - mozlog == 3.5 10:20:44 INFO - moznetwork == 0.27 10:20:44 INFO - mozprocess == 0.25 10:20:44 INFO - mozprofile == 0.28 10:20:44 INFO - mozrunner == 6.13 10:20:44 INFO - mozscreenshot == 0.1 10:20:44 INFO - mozsystemmonitor == 0.3 10:20:44 INFO - moztest == 0.8 10:20:44 INFO - mozversion == 1.4 10:20:44 INFO - psutil == 3.1.1 10:20:44 INFO - requests == 1.2.3 10:20:44 INFO - wsgiref == 0.1.2 10:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:44 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:44 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 10:20:44 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 10:20:44 INFO - Using env: {'DISPLAY': ':0', 10:20:44 INFO - 'HOME': '/home/cltbld', 10:20:44 INFO - 'LANG': 'en_US.UTF-8', 10:20:44 INFO - 'LANGUAGE': 'en_US:en', 10:20:44 INFO - 'LOGNAME': 'cltbld', 10:20:44 INFO - 'MAIL': '/var/mail/cltbld', 10:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:44 INFO - 'MOZ_NO_REMOTE': '1', 10:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:44 INFO - 'NO_EM_RESTART': '1', 10:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:44 INFO - 'PWD': '/builds/slave/test', 10:20:44 INFO - 'SHELL': '/bin/bash', 10:20:44 INFO - 'SHLVL': '1', 10:20:44 INFO - 'TERM': 'linux', 10:20:44 INFO - 'TMOUT': '86400', 10:20:44 INFO - 'USER': 'cltbld', 10:20:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:44 INFO - '_': '/tools/buildbot/bin/python'} 10:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 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)) 10:20:44 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:20: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 10:20: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 10:20: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 10:20: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 10:20:45 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:20:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:20:46 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)) 10:20:46 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)) 10:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:20:46 INFO - Installing collected packages: marionette-driver, simplejson 10:20:46 INFO - Running setup.py install for marionette-driver 10:20:46 INFO - Running setup.py install for simplejson 10:20:46 INFO - building 'simplejson._speedups' extension 10:20:46 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 10:20:47 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 10:20:47 INFO - Successfully installed marionette-driver simplejson 10:20:47 INFO - Cleaning up... 10:20:47 INFO - Return code: 0 10:20:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:47 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 0x20761f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2242a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e7b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, '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': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', '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 10:20:47 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 10:20:47 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 10:20:47 INFO - Using env: {'DISPLAY': ':0', 10:20:47 INFO - 'HOME': '/home/cltbld', 10:20:47 INFO - 'LANG': 'en_US.UTF-8', 10:20:47 INFO - 'LANGUAGE': 'en_US:en', 10:20:47 INFO - 'LOGNAME': 'cltbld', 10:20:47 INFO - 'MAIL': '/var/mail/cltbld', 10:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:47 INFO - 'MOZ_NO_REMOTE': '1', 10:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:47 INFO - 'NO_EM_RESTART': '1', 10:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:47 INFO - 'PWD': '/builds/slave/test', 10:20:47 INFO - 'SHELL': '/bin/bash', 10:20:47 INFO - 'SHLVL': '1', 10:20:47 INFO - 'TERM': 'linux', 10:20:47 INFO - 'TMOUT': '86400', 10:20:47 INFO - 'USER': 'cltbld', 10:20:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:47 INFO - '_': '/tools/buildbot/bin/python'} 10:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:20:47 INFO - Cleaning up... 10:20:47 INFO - Return code: 0 10:20:47 INFO - Running post-action listener: _resource_record_post_action 10:20:47 INFO - Running post-action listener: _start_resource_monitoring 10:20:47 INFO - Starting resource monitoring. 10:20:47 INFO - [mozharness: 2017-07-16 17:20:47.709723Z] Finished create-virtualenv step (success) 10:20:47 INFO - [mozharness: 2017-07-16 17:20:47.710714Z] Running install step. 10:20:47 INFO - Running pre-action listener: _resource_record_pre_action 10:20:47 INFO - Running main action method: install 10:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:20:47 INFO - Reading from file tmpfile_stdout 10:20:47 INFO - Detecting whether we're running mozinstall >=1.0... 10:20:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:20:48 INFO - Reading from file tmpfile_stdout 10:20:48 INFO - Output received: 10:20:48 INFO - Usage: mozinstall [options] installer 10:20:48 INFO - Options: 10:20:48 INFO - -h, --help show this help message and exit 10:20:48 INFO - -d DEST, --destination=DEST 10:20:48 INFO - Directory to install application into. [default: 10:20:48 INFO - "/builds/slave/test"] 10:20:48 INFO - --app=APP Application being installed. [default: firefox] 10:20:48 INFO - mkdir: /builds/slave/test/build/application 10:20:48 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'] 10:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:21:05 INFO - Reading from file tmpfile_stdout 10:21:05 INFO - Output received: 10:21:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:05 INFO - Running post-action listener: _resource_record_post_action 10:21:05 INFO - [mozharness: 2017-07-16 17:21:05.779261Z] Finished install step (success) 10:21:05 INFO - [mozharness: 2017-07-16 17:21:05.779515Z] Running setup-mitmproxy step. 10:21:05 INFO - Running pre-action listener: _resource_record_pre_action 10:21:05 INFO - Running main action method: setup_mitmproxy 10:21:05 INFO - Skipping: mitmproxy is not required 10:21:05 INFO - Running post-action listener: _resource_record_post_action 10:21:05 INFO - [mozharness: 2017-07-16 17:21:05.780643Z] Finished setup-mitmproxy step (success) 10:21:05 INFO - [mozharness: 2017-07-16 17:21:05.780882Z] Running run-tests step. 10:21:05 INFO - Running pre-action listener: _resource_record_pre_action 10:21:05 INFO - Running pre-action listener: _set_gcov_prefix 10:21:05 INFO - Running main action method: run_tests 10:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:05 INFO - Python 2.7.3 10:21:05 INFO - Return code: 0 10:21:05 INFO - grabbing minidump binary from tooltool 10:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:05 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 0x23e4d00>, '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 0x23e5c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e6090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:05 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 10:21:05 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 10:21:05 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 10:21:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:05 INFO - Return code: 0 10:21:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:05 INFO - ENV: RUST_BACKTRACE is now 1 10:21:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:05 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/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:21:05 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/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:21:05 INFO - Using env: {'DISPLAY': ':0', 10:21:05 INFO - 'HOME': '/home/cltbld', 10:21:05 INFO - 'LANG': 'en_US.UTF-8', 10:21:05 INFO - 'LANGUAGE': 'en_US:en', 10:21:05 INFO - 'LOGNAME': 'cltbld', 10:21:05 INFO - 'MAIL': '/var/mail/cltbld', 10:21:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:05 INFO - 'MOZ_NO_REMOTE': '1', 10:21:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:05 INFO - 'NO_EM_RESTART': '1', 10:21:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:05 INFO - 'PWD': '/builds/slave/test', 10:21:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:05 INFO - 'RUST_BACKTRACE': '1', 10:21:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:21:05 INFO - 'SHELL': '/bin/bash', 10:21:05 INFO - 'SHLVL': '1', 10:21:05 INFO - 'TERM': 'linux', 10:21:05 INFO - 'TMOUT': '86400', 10:21:05 INFO - 'USER': 'cltbld', 10:21:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489', 10:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:05 INFO - '_': '/tools/buildbot/bin/python'} 10:21:05 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/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:21:06 INFO - mozversion application_buildid: 20170716161811 10:21:06 INFO - mozversion application_changeset: 5f44d10bacca2d693413b529e0caadc73e634e1e 10:21:06 INFO - mozversion application_display_name: Nightly 10:21:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:06 INFO - mozversion application_name: Firefox 10:21:06 INFO - mozversion application_remotingname: firefox 10:21:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:21:06 INFO - mozversion application_vendor: Mozilla 10:21:06 INFO - mozversion application_version: 56.0a1 10:21:06 INFO - mozversion platform_buildid: 20170716161811 10:21:06 INFO - mozversion platform_changeset: 5f44d10bacca2d693413b529e0caadc73e634e1e 10:21:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:21:06 INFO - mozversion platform_version: 56.0a1 10:21:06 INFO - using testdate: 1500225666 10:21:06 INFO - actual date: 1500225666 10:21:06 INFO - starting webserver on 'localhost:47541' 10:21:06 INFO - SUITE-START | Running 2 tests 10:21:06 INFO - TEST-START | dromaeo_css 10:21:06 INFO - Initialising browser for dromaeo_css test... 10:21:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47541/getInfo.html -profile /tmp/tmpoLznbi/profile 10:21:06 INFO - TEST-INFO | started process 3336 (/builds/slave/test/build/application/firefox/firefox http://localhost:47541/getInfo.html) 10:21:13 INFO - TEST-INFO | 3336: exit 0 10:21:14 INFO - Browser initialized. 10:21:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:14 INFO - TEST-INFO | started process 3544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoLznbi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:25 INFO - PID 3544 | RSS: Main: 164106240 10:21:25 INFO - PID 3544 | 10:24:23 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47541/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47541/tests/dromaeo/cssquery-ext.html) 10:24:24 INFO - PID 3544 | RSS: Main: 169455616 10:24:24 INFO - PID 3544 | 10:27:26 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47541/tests/dromaeo/cssquery-ext.html (next: http://localhost:47541/tests/dromaeo/cssquery-jquery.html) 10:27:27 INFO - PID 3544 | RSS: Main: 167186432 10:27:27 INFO - PID 3544 | 10:30:28 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47541/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47541/tests/dromaeo/cssquery-mootools.html) 10:30:29 INFO - PID 3544 | RSS: Main: 169807872 10:30:29 INFO - PID 3544 | 10:33:30 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47541/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47541/tests/dromaeo/cssquery-prototype.html) 10:33:31 INFO - PID 3544 | RSS: Main: 169013248 10:33:31 INFO - PID 3544 | 10:36:34 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47541/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47541/tests/dromaeo/cssquery-yui.html) 10:36:34 INFO - PID 3544 | RSS: Main: 168587264 10:36:34 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | Cycle 1(1): loaded http://localhost:47541/tests/dromaeo/cssquery-yui.html (next: http://localhost:47541/tests/dromaeo/cssquery-dojo.html) 10:39:36 INFO - PID 3544 | RSS: Main: 171618304 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | __start_tp_report 10:39:36 INFO - PID 3544 | _x_x_mozilla_page_load 10:39:36 INFO - PID 3544 | _x_x_mozilla_page_load_details 10:39:36 INFO - PID 3544 | |i|pagename|runs| 10:39:36 INFO - PID 3544 | |0;dojo.html;3356.7985920844735;3418.589769227693;3433.6223015468295;3442.466417705255;3476.947845782314;6146.323904370522;6158.6612736299485;6181.350958149397;6182.567220294582;6214.968925155374;6257.186565746458;6261.561690681654;6268.247810262775;6268.404501572355;6277.246730392348;5435.347758269013;5442.047641662713;5451.672899626015;5460.31746031746;5512.641678290918;5411.377691565481;5440.755166017519;5450.100733378988;5467.753951072212;5469.863253418656;5479.53423958964;5480.287562616854;5480.369757477902;5481.698506582136;5490.149026900836;5480.91778623319;5503.6147469677135;5508.256385387961;5515;5515.669059856422;5428.511433970962;5475.288212532345;5531.668099914018;5535.197396377503;5597.384287728347;6197.628142311476;6206.410391012847;6267;6269.7178626961895;6277.905831412532;6621.93378066218;6706.899396509057;6724.462043036546;6733.528652994292;6811.693473793691;6683.93316066838;6728.495362847806;6748.19021717397;6753.054572359824;6756.864862702719;6196.946519091765;6219;6238.563300568962;6239.844003899893;6252.624842509464;6887.001384799226;7000.334968178015;7015.543989640657;7079.398251148607;7087.397571206505;6620.66896655175;6650.667466626746;6662.900056499157;6666.100076489709;6752.696128674222;6673.833154171088;6774.966125169342;6794.796156115324;6848.897266541006;6895.275996020346;6619.106420633249;6619.933800662028;6637.46900247979;6673.566218195899;6717.294684058202;6813.829654258584;6818.454523638097;6830.385265326145;6876.17485901695;6881.931180688229;4945.134601444733;5077.822276220315;5122.308488354099;5131.435542090367;5158;4423.712458690239;4455.487618923865;4463.24124898768;4506.369108324837;4603.470600880874;6231.875362492816;6258.624482531062;6264.68676566179;6270.31026587075;6281.089242059968;6650.102236198051;6731.697073631698;6746.898796518056;6813.046173535709;6817.113775209191;6192.009278515506;6194.38056194386;6249.406306400884;6254.593451425642;6285.779997700059;5672.688002159838;5742.7702891883855;5750.539956803445;5759.65442073477;5813.157092221604;6931.792046238621;6948.200956890022;6952.478564107712;6953.269906659728;7039.260877607778;6680.465562754968;6730.528862979741;6730.629815360202;6735.393814556714;6737.59574425536;6986.47601429905;6992.265812089658;7010.649467526705;7011.26381729911;7020.859582808417;6550.377714117151;6628.734850605922;6631.3700198481065;6640.966795165993;6660.500462465237;6899.862002760017;6917.377436030782;6927.58434493932;7029.789106326818;7032.437405007689;6637.502187335873;6653.733850646114;6726.596404215763;6729.226138994079;6763.458923286224;6457.967710161419;6629.207331943193;6642.867142657216;6732.528722989344;6765.661716914036;6202.7208775606105;6552.312007239171;6598.472122230306;6615.867682646416;6629.602223866584;6629.7679581214425;6639.103720997604;6672.165979252593;6713.12729345182;6719.865602687821;6324.051392291193;6399.55203135776;6484.967575162094;6496.0580715795;6521.706523206372 10:39:36 INFO - PID 3544 | |1;ext.html;851.6085940109094;894.1790122851565;910.3445519226158;931.4644079654196;932.1005229953103;40224.396634050514;40930.181396372056;40934.79532602336;41017.79491102548;41107.17785644285;37577.24845503088;41788;41854;42262.78868605661;42489.150216995644;7195.172555156146;7340.779776606711;7379.335859772619;7394.667239974214;7400.851982960337;7163.820904477378;7298.52559583628;7315.817104572375;7322.597257150855;7328.230535793745;7332.450066245026;7340.045794046767;7356.411487081021;7374.778756637309;7375.557466552024;7276;7331.266873312653;7346.706131754723;7357.668904899238;7361.4846960712775;7171.9282807171785;7188.604626745527;7192.892106618405;7222.891656625155;7233.023541821839;38287.42568861469;38799.22401551953;38880.22239555221;39006.414903776466;39035.21929561421;3437.553118094657;3463.9480407793903;3472.5485686860798;3477.3914564951288;3489.825508724579;30234.24414389658;30294.242643934078;30321.393572128654;30418.695813041806;30451.69548304533;4760.071786001731;4781.187198176319;4937.284093806414;4959.553640172366;5003.17447621142;196678;196978;232805;241711.79144104343;243872;49484;49520;49619.75190124098;49869;49931;50792;51339.48660513422;51375.48624513707;51486;51647.741761291705;16500.83499165017;16680.74978875318;16731.91634041822;16764.161791910356;16773.329066837436;13532.188068715908;13565.186088834702;13650.795238071438;13714.51999180024;13731.931340343235;14648.780268295985;14682.779758303634;14710.852891471162;14762.335694893542;14837.183954882585;5679.346875109332;5750.539956803445;5774.769009239667;5895.823125306248;6030.246219222598;1081.551156270139;1088.472091035847;1091.5633746501462;1115.4367044642404;1115.6708770912437;30549.08352749421;30563.69436305653;31570.684293157236;31761.841190793897;32005.199870003435;1169.426980779412;1185.266410805968;1189.9647306842928;1192.7554851255472;1195.5397172088808;13376.866231337757;13410.329483525784;13434.932825336005;13452.596422107352;13591.592252232449;262432;271307;272254;277250;280881;60012.99999999913;60064.69967650134;60339.39660603338;60386;60635.09047364293;1494.0736743219275;1506.8417816129368;1523.512476007667;1525.3212320517264;1531.341523145036;28664.426711466072;29068.854655726587;29390.853045734635;29515.262118447212;29546.409071818875;39511.60488395079;39577.80211098926;39874.2025159501;39963.80018099891;45118.77440612776;227431;227854;242053;242436;243890;34202.82898585591;34421.48367774535;34561.30877382489;34632;38528.4956477828;47999.76000119977;48120.51879481161;48170.759146204044;48271;48967;32587.34825303433;33309.29634621253;34901.12747181341;35178;35195.82402087973;33199;33932.32135357329;33963.830180848934;34369.828150860085;34392.656073439946;40351.58769443056;40731.38902916518;40830.387544187455;40838.18323633451;40999;31899.521507176945;33462.4980625286;34143.487847681805;34319.656803431644;34410.82794586011;26243.73756262413;26268.73731262663;26271.343216419744;26878.193654190407;26895.462090757683 10:39:36 INFO - PID 3544 | |2;jquery.html;560.2240896358542;574.4600075928627;576.0926540698401;581.5899790647593;596.9253843269591;21624.783752162475;22962.540749185006;23031.309060728163;23142.53714925705;23170;25410.237692869196;25849.74150258497;26865.328366790793;27008.594871076948;27256.5911511327;6217.564770466058;6285.4971602271935;6320.494360451153;6334.144890439801;6352.650604216767;6228.19033525641;6276.623402595836;6277.2467303923595;6278.497720182374;6285.214348206474;5740.339860915986;6125.72434240458;6231.40801623845;6248.781292654758;6260.029695397221;5948.286205655306;6042.214512113419;6048.667323297217;6057.454829065383;6065.939340606582;5627.593101724568;5638.379778224433;5648.237487939116;5651.378348381716;5668.376478587352;29741.553876691865;31686.524702129256;32322.838385808154;32357.191070223198;32358;2125.87244765313;2161.7838216178416;2167.1548096242477;2169.1648715244587;2174.3368272676826;19402.80597194024;20116.49708757278;20205.191792328435;20217.696734548994;20235.595288094304;2320.721513418384;2377.9881100594557;2381.38084098134;2414.1188466209883;2422.854628722265;142150;145890;146592;148944;152206;14771.704565908622;15662.00618842188;15664.451744189126;15855.52433426999;16064.357425703074;24241.03035878545;24275.271741847773;24304.392390190034;24349.63475547868;24558.508829823302;9473.715788526355;9545.284103692251;9553.90446095544;9751.804963900682;9758.951205243928;8473.279771219391;8475.788105297417;8519.701810436729;8530;8636.611352489028;9371;9790.902090979142;9792.902070979342;9798.216142708567;9825.115739583473;2698.9730102699114;2794.3153927287944;2844.6586409630977;2854.67171275306;2888.046944508307;1030.9742256443499;1039.896010398954;1044.9582016719398;1076.8761592416815;1078.2721662877527;20644.69032964507;21088.261910833047;21336.893315533634;21532.354029379145;22061.448463788533;1085.5603480590373;1088.7985722641179;1106.9282740395467;1132.750794825137;1138.117958582089;11483.598074067368;11783.705407364885;11806.94096529529;12062.457189426497;12093.60923493792;565041;592292;596291;608768;620323;136606;140683;143607.2819635916;143934;145624.27187863993;1301.6680746409795;1313.343328335832;1376.7040086381476;1377.7657798174334;1379.889608831311;22275.888620556794;22851.20020799264;23145.421364466023;23279.76720232776;23373.181938632068;64760.352396475435;66628.66685666541;66717.33282667305;67164.3283567158;68929.31070689228;84747.5762621183;85793.85515362165;86534.1346586526;86896.56551717201;86994.56502717445;14484.34820433062;14584.854151458774;14981.925090374914;15114.244287785787;15228.390864365301;24201.51596968086;24335.26994190177;24424;24669.87665061735;24961.12636057729;19861;20017.29939452112;20062;20301.390958270684;20454.181832726525;17347.739783902998;17380.70583105821;17715.557111071812;18145.637087258445;18406.631867362845;20354.59290814205;20356.28752993638;20414.285500007427;20568.177272908917;20638.17447302151;14704.705905882036;14934.626634334229;15002.924985375003;15063.322150503034;15119.848801511844;20474.38576842697;20734;20772.065257063772;20829.270975515785;20891.26880559173 10:39:36 INFO - PID 3544 | |3;mootools.html;1413.688988422547;1437.223899094489;1441.6756229848286;1444.328387299906;1484.7475929092057;15101.546953591382;15682.137482438462;15785.342539033409;15844.049357038586;15888.126153061577;15078.09531428115;15499.690006199897;15527;15577.688446231068;15599.1420471874;2567.15283956294;2610.5562054450693;2618.384679600292;2619.7511236432606;2623.331050582108;2605.9348516287055;2676.37105280259;2686.382132109616;2698.662667166604;2700.66241719785;2577.1495406515805;2596.9870150649313;2614.1504011196344;2619.6332513448133;2621.4757048590263;2515.207709571479;2528.3679080229945;2529.747025297474;2531.1014589820534;2545.096490745777;2449.3998970252223;2495.0643508684243;2515.924522264335;2517.2699917024224;2519.722830488645;14886.330115144845;15087.170205638686;15152.393904243818;15242.161681107535;15250.847491525054;7779.144294127642;8070.677172913076;8072;8075.434719569633;8082.757517274491;5110.488951104897;5116.079105760961;5195.870103247411;5319.2287118368;5320.893582128375;1847.9815201848078;1859.5258209156714;1878.0797409269496;1886.9811301886944;1927.1231589626686;23522.411939701644;24136.87931560331;26289.868550657317;26550.6017409739;26608.06871759479;6050.969745151246;6147.108669242934;6667.299933506912;6950.061741664912;6967.825804354931;18103.366382176562;18202.54493637643;18235.72646410305;18245.178966946518;18265.543361415806;7680.231976802387;8018.158093400226;8036.638351274207;8041.758747237593;8072.515649061075;7402.185759566443;7413.4810563261135;7419.517731347445;7428.665710043061;7485;5234.842954711365;5361.1422172453;5405.567554595623;5416.9729151353995;5445.700486473282;1422.559006707903;1455.2432734977751;1456.4829485532696;1468.6181592785738;1486.0786312486111;901.3150005995491;916.9495677737789;938.7840796616816;939.5302348825587;945.5555888732284;7870.606469676493;7911.28798408146;7939.483933544301;7962.840743185104;8001.679932802623;737.2148661675299;742.7808796405074;762.4967521435826;770.1220608506308;782.8943092682529;5056.797728090835;5095.363079615048;6003.369646187088;6071.483923866521;6317.305096439388;21915;22682.88658556697;22699.432514187276;22744.431389215402;22782;21293.46766330823;21586.35240942774;21606.567868642855;22020.11919523233;22024;11338.773224535464;11851.585194518151;11935.403229838474;12054.397280135958;12367.876321236672;8628.827423451621;9161.679341223025;9167.77080572991;9319.813603727753;9484.52577371115;17801.73297400566;18526.536836579195;18832.24671013144;19066.951317677107;19703.507412314808;17372.47882563525;18947.43157705271;19682.11430485603;20066.89966550158;20302.898485507478;12214.450349734461;12490.687732806753;13059.34703264852;13078.411471483996;13131.803022954473;14358.712825743636;14526.636834079232;14588.270586470846;14667.633309167357;14678.119312841263;11255.155863310121;11278.605248816251;11403.885961140615;11454.656360309204;11794.705132371417;10911.290766100177;11257.099432045254;11484.081273498266;11661.24201926872;11871.287722736663;10175.643852465128;10184.338018028804;10184.338018028804;10336.379817210991;10368.274220804471;7667.616619169131;7740.651670674721;7867.84264314722;7883.132855385788;7942.6028698566;7692.807679808049;7711.190325015793;7785.688572457038;7832.177621349904;7832.255935686101 10:39:36 INFO - PID 3544 | |4;prototype.html;514.6500379741778;516.4422423782314;528.2419727690764;535.1410985368484;535.7879512323618;6061.7575296988125;6149.231346081734;6219.937800621992;6239.937600623993;6266.655333956631;6001.549883758725;6008.969955150229;6061.605995610283;6148.309214965887;6180.314111017863;4857.465678775332;4873.488283730201;4879.365682461275;4887.291342755316;4911.919377736892;4841.56425921667;4858.805647774085;4864.270359446094;4885.291632713254;4894.3147959285725;4777.614491797392;4814.7351895645725;4819.7590120494015;4867.610591152717;4878.65849390541;4813.951860481386;4827;4867.4889136640495;4900.338454308676;4933.777979990909;4132.710710250284;4271.188474189894;4279.1869544786705;4444.133393988173;4448.5773851484055;5895.553345361713;5914.674692891889;5931.940680593182;5965.343812180657;6020.337762846083;5654.6324488908085;5655.434456554352;5702.287214098238;5713.514351280146;5714.685342631351;6504.447121994636;6513.218413790328;6553.3446655334565;6603.504737144734;6618.735250589971;4913.434954980187;4915.73876017029;4922.80308787648;4926.512111383764;4930.728809915453;6558.1802274715665;6727.899081513781;6874.312568743136;6878.140232470942;6981.2669669684965;4914.845011422313;5032.949670503248;5047.343845300161;5055.191169412877;5064.11378008847;5058.190689489664;5099.770510327045;5112.437631860493;5121.897562048738;5128.538431541105;5621.325440947031;5716.342620598684;5745.2818397700285;5747.655140691572;5768.154190659033;6581.736730530725;6635.834104147339;6642.6014439133805;6652.933470665328;6662.83342916431;1759.9296028158985;1760.119940029985;1762.7884653841365;1765.6203916158088;1772.211365942169;1165.0504838556549;1223.467791510678;1235.32057368447;1235.8640549539543;1241.3606992398923;6073.48375388097;6094.465210178175;6135.478484328882;6172.69136543171;6196.938030619636;6612.908870036486;6658.400743932973;6699.688607430428;6707.66461676924;6728.697208625624;6071.787487437919;6085;6091.939080609137;6106.542009349317;6107.6640784757265;3513.9648603514147;3576.660217279354;3589.8025608591256;3590.1563132663805;3610.6028336882923;6886.276940921131;6975.8604827903155;7022.92670251253;7035.401990830836;7048.753293634698;6790.72837086511;6821.897671534931;6858.485613579001;6903.413209877217;6939.583624982517;7005.649717514206;7014.562014787059;7042.964785176041;7050.294970502909;7065.399441047466;6103.3591472894705;6651.104435235935;6663.666816659051;6742.393184613212;6756.628385438848;6531.967340163269;6557.704903279268;6562.278149403657;6566.24488183865;6570.685862827358;6925.342092501204;6965.373116419547;7040.331168538981;7046.894296585658;7068.727629026825;5020.397552293602;5041.521055499722;5049.57078648319;5056.84829455117;5072.923906141485;6565;6616.966915165393;6673.499487538357;6743.763968261087;6762.222344430454;6312.4634406076;6365.745370185141;6420.486361091008;6484.286728459771;6497.805065848032;6427.260865000585;6430.48556115519;6484.481241500763;6520.576162549419;6562.80311590653;6420.65166315079;6545.672716364258;6561.901571476336;6568.967155164193;6583.901241481286;6543.214814222324;6570;6599.340065993362;6603.80188594343;6614.90077648826;6400.519961003037;6412.198475190601;6412.39082287182;6436.742530298736;6470.191226096738 10:39:36 INFO - PID 3544 | |5;yui.html;942.081470566198;944.5053302779714;956.4452617481861;961.7884065505586;965.4159233663631;14743;14894.925525372359;14928.552143435714;14989.175595342265;18070;16128.274227659755;16178.514644560653;16355.345786168538;17912.78882187972;18201.544961375974;1016.3089099412397;1043.639944219243;1044.8067107585084;1048.4705223861938;1052.763128296131;1058.2856571814034;1073.1897417449854;1073.3613499967507;1073.5759375046853;1078.6170909327193;1135.4663308245113;1144.5193018932068;1146.2950285574354;1146.340854008944;1146.8107762219265;1009.0565321424418;1079.5843600213896;1124.7244425115816;1133.9489722962446;1139.5669645534686;796.1918652567648;801.7554645833019;803.6704950970075;807.1000834070028;812.9878301514593;18877.244910203575;19033.143508542147;19039;19074.23703051876;19109.713354299696;19581.314653987185;20153.596928061357;20546.383608491768;20776.68834967477;20908.686369704315;15998.680026399523;16144;16261.10563918984;16395.836041639668;16622.58443538909;3118.251619611277;3135.8745650173964;3237.692419220194;3242.1408326793417;3268.7221586165206;96515.0348496513;135821;139344;140135.29932350272;141214;16521.91739041321;16922.23849926756;17138.228779704943;17513.56216094608;17593.208305626278;30852.22869428282;32033.51949720756;32361;32421.837890810395;32459.35081298361;9232.076792320715;9284;9289.44263344188;9295.674651387304;9296.209822165056;4344.82620695175;4408.470983482002;4457.331400289982;4457.398251236106;4495.348174514677;5374.838754837361;5475.972620136953;5493.7802487900035;5501.559875209973;5503.477169668875;1088.689723428819;1106.5573770491867;1147.52377763229;1148.74153315505;1155.5089087137933;677.806825054857;682.1984168601873;685.4447897203281;707.2467821769799;709.6912842913349;12184.147109702235;12508.687282818002;12585.433655485525;12802.487900483877;12828.615141545768;716.6631683108931;727.9272072792784;730.1709218407855;734.9559026458429;758.4198088462331;5789.710514474259;5866.208061911672;5890.646561206256;5947.583669143205;6077.3314935357075;119203;123939.3803030979;124364;128000.35999819942;130941;110424.4478777601;112848;113392.43303783429;116113.41943290399;116919.41540292244;98124;98943;100018.4999075;101038.4948075255;101058.49470752747;12374.319412432402;12538.868392373137;12633.494660213488;12739.363031848185;13150.408231629408;45910.77044614756;46076.7696161517;46757.29864051974;47122.29316560323;47875.76062119667;54687.17969230544;57256.42743572678;57744.1338379933;58119;58963.41036589579;15973.520794376187;17388;19508.609827803648;19565.315213967442;19946.501337466678;20534.58930821405;20788.896055519624;21000.474988125417;21650.783492164875;22108.115675372806;16804.495865124067;17671.91164044223;17703.29186832564;18073;19362.128704208062;17900.91049544744;18010.72983905269;18239;18514.16686249095;18682.25270989145;19450.8054919449;19959;20038.49903752418;20062.49843753918;20333.6949945748;11713.1800773945;12295.877041229473;12421.44103515362;12422.881940625388;13216.207027578375;12516.374181291081;13091.345432728516;13779.311034448037;14147.64630884195;15284.235788210322 10:39:36 INFO - PID 3544 | __end_tp_report 10:39:36 INFO - PID 3544 | __start_cc_report 10:39:36 INFO - PID 3544 | _x_x_mozilla_cycle_collect,313 10:39:36 INFO - PID 3544 | __end_cc_report 10:39:36 INFO - PID 3544 | __startTimestamp1500226776799__endTimestamp 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | ------- Summary: start ------- 10:39:36 INFO - PID 3544 | Number of tests: 6 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | [#0] dojo.html Cycles:165 Average:6212.78 Median:6550.38 stddev:791.99 (12.1%) stddev-sans-first:762.07 10:39:36 INFO - PID 3544 | Values: 3356.8 3418.6 3433.6 3442.5 3476.9 6146.3 6158.7 6181.4 6182.6 6215.0 6257.2 6261.6 6268.2 6268.4 6277.2 5435.3 5442.0 5451.7 5460.3 5512.6 5411.4 5440.8 5450.1 5467.8 5469.9 5479.5 5480.3 5480.4 5481.7 5490.1 5480.9 5503.6 5508.3 5515.0 5515.7 5428.5 5475.3 5531.7 5535.2 5597.4 6197.6 6206.4 6267.0 6269.7 6277.9 6621.9 6706.9 6724.5 6733.5 6811.7 6683.9 6728.5 6748.2 6753.1 6756.9 6196.9 6219.0 6238.6 6239.8 6252.6 6887.0 7000.3 7015.5 7079.4 7087.4 6620.7 6650.7 6662.9 6666.1 6752.7 6673.8 6775.0 6794.8 6848.9 6895.3 6619.1 6619.9 6637.5 6673.6 6717.3 6813.8 6818.5 6830.4 6876.2 6881.9 4945.1 5077.8 5122.3 5131.4 5158.0 4423.7 4455.5 4463.2 4506.4 4603.5 6231.9 6258.6 6264.7 6270.3 6281.1 6650.1 6731.7 6746.9 6813.0 6817.1 6192.0 6194.4 6249.4 6254.6 6285.8 5672.7 5742.8 5750.5 5759.7 5813.2 6931.8 6948.2 6952.5 6953.3 7039.3 6680.5 6730.5 6730.6 6735.4 6737.6 6986.5 6992.3 7010.6 7011.3 7020.9 6550.4 6628.7 6631.4 6641.0 6660.5 6899.9 6917.4 6927.6 7029.8 7032.4 6637.5 6653.7 6726.6 6729.2 6763.5 6458.0 6629.2 6642.9 6732.5 6765.7 6202.7 6552.3 6598.5 6615.9 6629.6 6629.8 6639.1 6672.2 6713.1 6719.9 6324.1 6399.6 6485.0 6496.1 6521.7 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | [#1] ext.html Cycles:180 Average:42010.98 Median:19195.48 stddev:63772.30 (332.2%) stddev-sans-first:63876.32 10:39:36 INFO - PID 3544 | Values: 851.6 894.2 910.3 931.5 932.1 40224.4 40930.2 40934.8 41017.8 41107.2 37577.2 41788.0 41854.0 42262.8 42489.2 7195.2 7340.8 7379.3 7394.7 7400.9 7163.8 7298.5 7315.8 7322.6 7328.2 7332.5 7340.0 7356.4 7374.8 7375.6 7276.0 7331.3 7346.7 7357.7 7361.5 7171.9 7188.6 7192.9 7222.9 7233.0 38287.4 38799.2 38880.2 39006.4 39035.2 3437.6 3463.9 3472.5 3477.4 3489.8 30234.2 30294.2 30321.4 30418.7 30451.7 4760.1 4781.2 4937.3 4959.6 5003.2 196678.0 196978.0 232805.0 241711.8 243872.0 49484.0 49520.0 49619.8 49869.0 49931.0 50792.0 51339.5 51375.5 51486.0 51647.7 16500.8 16680.7 16731.9 16764.2 16773.3 13532.2 13565.2 13650.8 13714.5 13731.9 14648.8 14682.8 14710.9 14762.3 14837.2 5679.3 5750.5 5774.8 5895.8 6030.2 1081.6 1088.5 1091.6 1115.4 1115.7 30549.1 30563.7 31570.7 31761.8 32005.2 1169.4 1185.3 1190.0 1192.8 1195.5 13376.9 13410.3 13434.9 13452.6 13591.6 262432.0 271307.0 272254.0 277250.0 280881.0 60013.0 60064.7 60339.4 60386.0 60635.1 1494.1 1506.8 1523.5 1525.3 1531.3 28664.4 29068.9 29390.9 29515.3 29546.4 39511.6 39577.8 39874.2 39963.8 45118.8 227431.0 227854.0 242053.0 242436.0 243890.0 34202.8 34421.5 34561.3 34632.0 38528.5 47999.8 48120.5 48170.8 48271.0 48967.0 32587.3 33309.3 34901.1 35178.0 35195.8 33199.0 33932.3 33963.8 34369.8 34392.7 40351.6 40731.4 40830.4 40838.2 40999.0 31899.5 33462.5 34143.5 34319.7 34410.8 26243.7 26268.7 26271.3 26878.2 26895.5 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | [#2] jquery.html Cycles:180 Average:39975.55 Median:12875.59 stddev:100295.47 (779.0%) stddev-sans-first:100533.16 10:39:36 INFO - PID 3544 | Values: 560.2 574.5 576.1 581.6 596.9 21624.8 22962.5 23031.3 23142.5 23170.0 25410.2 25849.7 26865.3 27008.6 27256.6 6217.6 6285.5 6320.5 6334.1 6352.7 6228.2 6276.6 6277.2 6278.5 6285.2 5740.3 6125.7 6231.4 6248.8 6260.0 5948.3 6042.2 6048.7 6057.5 6065.9 5627.6 5638.4 5648.2 5651.4 5668.4 29741.6 31686.5 32322.8 32357.2 32358.0 2125.9 2161.8 2167.2 2169.2 2174.3 19402.8 20116.5 20205.2 20217.7 20235.6 2320.7 2378.0 2381.4 2414.1 2422.9 142150.0 145890.0 146592.0 148944.0 152206.0 14771.7 15662.0 15664.5 15855.5 16064.4 24241.0 24275.3 24304.4 24349.6 24558.5 9473.7 9545.3 9553.9 9751.8 9759.0 8473.3 8475.8 8519.7 8530.0 8636.6 9371.0 9790.9 9792.9 9798.2 9825.1 2699.0 2794.3 2844.7 2854.7 2888.0 1031.0 1039.9 1045.0 1076.9 1078.3 20644.7 21088.3 21336.9 21532.4 22061.4 1085.6 1088.8 1106.9 1132.8 1138.1 11483.6 11783.7 11806.9 12062.5 12093.6 565041.0 592292.0 596291.0 608768.0 620323.0 136606.0 140683.0 143607.3 143934.0 145624.3 1301.7 1313.3 1376.7 1377.8 1379.9 22275.9 22851.2 23145.4 23279.8 23373.2 64760.4 66628.7 66717.3 67164.3 68929.3 84747.6 85793.9 86534.1 86896.6 86994.6 14484.3 14584.9 14981.9 15114.2 15228.4 24201.5 24335.3 24424.0 24669.9 24961.1 19861.0 20017.3 20062.0 20301.4 20454.2 17347.7 17380.7 17715.6 18145.6 18406.6 20354.6 20356.3 20414.3 20568.2 20638.2 14704.7 14934.6 15002.9 15063.3 15119.8 20474.4 20734.0 20772.1 20829.3 20891.3 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | [#3] mootools.html Cycles:180 Average:9525.84 Median:2516.60 stddev:6774.87 (269.2%) stddev-sans-first:6766.46 10:39:36 INFO - PID 3544 | Values: 1413.7 1437.2 1441.7 1444.3 1484.7 15101.5 15682.1 15785.3 15844.0 15888.1 15078.1 15499.7 15527.0 15577.7 15599.1 2567.2 2610.6 2618.4 2619.8 2623.3 2605.9 2676.4 2686.4 2698.7 2700.7 2577.1 2597.0 2614.2 2619.6 2621.5 2515.2 2528.4 2529.7 2531.1 2545.1 2449.4 2495.1 2515.9 2517.3 2519.7 14886.3 15087.2 15152.4 15242.2 15250.8 7779.1 8070.7 8072.0 8075.4 8082.8 5110.5 5116.1 5195.9 5319.2 5320.9 1848.0 1859.5 1878.1 1887.0 1927.1 23522.4 24136.9 26289.9 26550.6 26608.1 6051.0 6147.1 6667.3 6950.1 6967.8 18103.4 18202.5 18235.7 18245.2 18265.5 7680.2 8018.2 8036.6 8041.8 8072.5 7402.2 7413.5 7419.5 7428.7 7485.0 5234.8 5361.1 5405.6 5417.0 5445.7 1422.6 1455.2 1456.5 1468.6 1486.1 901.3 916.9 938.8 939.5 945.6 7870.6 7911.3 7939.5 7962.8 8001.7 737.2 742.8 762.5 770.1 782.9 5056.8 5095.4 6003.4 6071.5 6317.3 21915.0 22682.9 22699.4 22744.4 22782.0 21293.5 21586.4 21606.6 22020.1 22024.0 11338.8 11851.6 11935.4 12054.4 12367.9 8628.8 9161.7 9167.8 9319.8 9484.5 17801.7 18526.5 18832.2 19067.0 19703.5 17372.5 18947.4 19682.1 20066.9 20302.9 12214.5 12490.7 13059.3 13078.4 13131.8 14358.7 14526.6 14588.3 14667.6 14678.1 11255.2 11278.6 11403.9 11454.7 11794.7 10911.3 11257.1 11484.1 11661.2 11871.3 10175.6 10184.3 10184.3 10336.4 10368.3 7667.6 7740.7 7867.8 7883.1 7942.6 7692.8 7711.2 7785.7 7832.2 7832.3 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | [#4] prototype.html Cycles:180 Average:5545.64 Median:6107.10 stddev:1580.37 (25.9%) stddev-sans-first:1539.03 10:39:36 INFO - PID 3544 | Values: 514.7 516.4 528.2 535.1 535.8 6061.8 6149.2 6219.9 6239.9 6266.7 6001.5 6009.0 6061.6 6148.3 6180.3 4857.5 4873.5 4879.4 4887.3 4911.9 4841.6 4858.8 4864.3 4885.3 4894.3 4777.6 4814.7 4819.8 4867.6 4878.7 4814.0 4827.0 4867.5 4900.3 4933.8 4132.7 4271.2 4279.2 4444.1 4448.6 5895.6 5914.7 5931.9 5965.3 6020.3 5654.6 5655.4 5702.3 5713.5 5714.7 6504.4 6513.2 6553.3 6603.5 6618.7 4913.4 4915.7 4922.8 4926.5 4930.7 6558.2 6727.9 6874.3 6878.1 6981.3 4914.8 5032.9 5047.3 5055.2 5064.1 5058.2 5099.8 5112.4 5121.9 5128.5 5621.3 5716.3 5745.3 5747.7 5768.2 6581.7 6635.8 6642.6 6652.9 6662.8 1759.9 1760.1 1762.8 1765.6 1772.2 1165.1 1223.5 1235.3 1235.9 1241.4 6073.5 6094.5 6135.5 6172.7 6196.9 6612.9 6658.4 6699.7 6707.7 6728.7 6071.8 6085.0 6091.9 6106.5 6107.7 3514.0 3576.7 3589.8 3590.2 3610.6 6886.3 6975.9 7022.9 7035.4 7048.8 6790.7 6821.9 6858.5 6903.4 6939.6 7005.6 7014.6 7043.0 7050.3 7065.4 6103.4 6651.1 6663.7 6742.4 6756.6 6532.0 6557.7 6562.3 6566.2 6570.7 6925.3 6965.4 7040.3 7046.9 7068.7 5020.4 5041.5 5049.6 5056.8 5072.9 6565.0 6617.0 6673.5 6743.8 6762.2 6312.5 6365.7 6420.5 6484.3 6497.8 6427.3 6430.5 6484.5 6520.6 6562.8 6420.7 6545.7 6561.9 6569.0 6583.9 6543.2 6570.0 6599.3 6603.8 6614.9 6400.5 6412.2 6412.4 6436.7 6470.2 10:39:36 INFO - PID 3544 | 10:39:36 INFO - PID 3544 | [#5] yui.html Cycles:180 Average:24871.89 Median:18376.58 stddev:35385.15 (192.6%) stddev-sans-first:35438.80 10:39:36 INFO - PID 3544 | Values: 942.1 944.5 956.4 961.8 965.4 14743.0 14894.9 14928.6 14989.2 18070.0 16128.3 16178.5 16355.3 17912.8 18201.5 1016.3 1043.6 1044.8 1048.5 1052.8 1058.3 1073.2 1073.4 1073.6 1078.6 1135.5 1144.5 1146.3 1146.3 1146.8 1009.1 1079.6 1124.7 1133.9 1139.6 796.2 801.8 803.7 807.1 813.0 18877.2 19033.1 19039.0 19074.2 19109.7 19581.3 20153.6 20546.4 20776.7 20908.7 15998.7 16144.0 16261.1 16395.8 16622.6 3118.3 3135.9 3237.7 3242.1 3268.7 96515.0 135821.0 139344.0 140135.3 141214.0 16521.9 16922.2 17138.2 17513.6 17593.2 30852.2 32033.5 32361.0 32421.8 32459.4 9232.1 9284.0 9289.4 9295.7 9296.2 4344.8 4408.5 4457.3 4457.4 4495.3 5374.8 5476.0 5493.8 5501.6 5503.5 1088.7 1106.6 1147.5 1148.7 1155.5 677.8 682.2 685.4 707.2 709.7 12184.1 12508.7 12585.4 12802.5 12828.6 716.7 727.9 730.2 735.0 758.4 5789.7 5866.2 5890.6 5947.6 6077.3 119203.0 123939.4 124364.0 128000.4 130941.0 110424.4 112848.0 113392.4 116113.4 116919.4 98124.0 98943.0 100018.5 101038.5 101058.5 12374.3 12538.9 12633.5 12739.4 13150.4 45910.8 46076.8 46757.3 47122.3 47875.8 54687.2 57256.4 57744.1 58119.0 58963.4 15973.5 17388.0 19508.6 19565.3 19946.5 20534.6 20788.9 21000.5 21650.8 22108.1 16804.5 17671.9 17703.3 18073.0 19362.1 17900.9 18010.7 18239.0 18514.2 18682.3 19450.8 19959.0 20038.5 20062.5 20333.7 11713.2 12295.9 12421.4 12422.9 13216.2 12516.4 13091.3 13779.3 14147.6 15284.2 10:39:36 INFO - PID 3544 | -------- Summary: end -------- 10:39:36 INFO - PID 3544 | 10:39:37 INFO - TEST-INFO | 3544: exit 0 10:39:37 INFO - TEST-OK | dromaeo_css | took 1110979ms 10:39:37 INFO - TEST-START | kraken 10:39:37 INFO - Initialising browser for kraken test... 10:39:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47541/getInfo.html -profile /tmp/tmpfWu97L/profile 10:39:37 INFO - TEST-INFO | started process 3951 (/builds/slave/test/build/application/firefox/firefox http://localhost:47541/getInfo.html) 10:39:43 INFO - TEST-INFO | 3951: exit 0 10:39:43 INFO - Browser initialized. 10:39:43 INFO - Running cycle 1/1 for kraken test... 10:39:43 INFO - TEST-INFO | started process 4157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfWu97L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:54 INFO - PID 4157 | RSS: Main: 160071680 10:39:54 INFO - PID 4157 | 10:39:57 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47541/tests/kraken/driver.html?testName=audio-beat-detection) 10:39:58 INFO - PID 4157 | RSS: Main: 166412288 10:39:58 INFO - PID 4157 | 10:40:00 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47541/tests/kraken/driver.html?testName=audio-dft) 10:40:01 INFO - PID 4157 | RSS: Main: 166576128 10:40:01 INFO - PID 4157 | 10:40:04 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47541/tests/kraken/driver.html?testName=audio-fft) 10:40:04 INFO - PID 4157 | RSS: Main: 161562624 10:40:04 INFO - PID 4157 | 10:40:06 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47541/tests/kraken/driver.html?testName=audio-oscillator) 10:40:07 INFO - PID 4157 | RSS: Main: 162017280 10:40:07 INFO - PID 4157 | 10:40:09 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47541/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:10 INFO - PID 4157 | RSS: Main: 161792000 10:40:10 INFO - PID 4157 | 10:40:13 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47541/tests/kraken/driver.html?testName=imaging-darkroom) 10:40:13 INFO - PID 4157 | RSS: Main: 161976320 10:40:13 INFO - PID 4157 | 10:40:17 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47541/tests/kraken/driver.html?testName=imaging-desaturate) 10:40:17 INFO - PID 4157 | RSS: Main: 165392384 10:40:17 INFO - PID 4157 | 10:40:20 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47541/tests/kraken/driver.html?testName=json-parse-financial) 10:40:21 INFO - PID 4157 | RSS: Main: 165703680 10:40:21 INFO - PID 4157 | 10:40:22 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47541/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:40:23 INFO - PID 4157 | RSS: Main: 165769216 10:40:23 INFO - PID 4157 | 10:40:24 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:40:25 INFO - PID 4157 | RSS: Main: 165527552 10:40:25 INFO - PID 4157 | 10:40:27 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:28 INFO - PID 4157 | RSS: Main: 165236736 10:40:28 INFO - PID 4157 | 10:40:30 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:40:31 INFO - PID 4157 | RSS: Main: 165720064 10:40:31 INFO - PID 4157 | 10:40:34 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:40:34 INFO - PID 4157 | RSS: Main: 165629952 10:40:34 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | Cycle 1(1): loaded http://localhost:47541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47541/tests/kraken/driver.html?testName=ai-astar) 10:40:36 INFO - PID 4157 | RSS: Main: 167378944 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | __start_tp_report 10:40:36 INFO - PID 4157 | _x_x_mozilla_page_load 10:40:36 INFO - PID 4157 | _x_x_mozilla_page_load_details 10:40:36 INFO - PID 4157 | |i|pagename|runs| 10:40:36 INFO - PID 4157 | |0;ai-astar;107;97;108;108;105;109;107;109;107;108 10:40:36 INFO - PID 4157 | |1;audio-beat-detection;146;115;143;173;120;151;144;116;166;127 10:40:36 INFO - PID 4157 | |2;audio-dft;162;162;162;164;161;171;163;160;160;164 10:40:36 INFO - PID 4157 | |3;audio-fft;75;76;73;188;74;75;74;74;163;75 10:40:36 INFO - PID 4157 | |4;audio-oscillator;81;80;136;80;81;80;124;82;81;129 10:40:36 INFO - PID 4157 | |5;imaging-gaussian-blur;114;114;114;114;113;113;113;114;114;113 10:40:36 INFO - PID 4157 | |6;imaging-darkroom;148;148;149;149;147;148;149;149;146;150 10:40:36 INFO - PID 4157 | |7;imaging-desaturate;95;93;94;94;94;94;94;95;95;96 10:40:36 INFO - PID 4157 | |8;json-parse-financial;49;47;47;48;48;51;50;48;47;50 10:40:36 INFO - PID 4157 | |9;json-stringify-tinderbox;54;54;54;53;54;54;54;54;53;54 10:40:36 INFO - PID 4157 | |10;stanford-crypto-aes;75;75;74;74;78;75;75;74;74;75 10:40:36 INFO - PID 4157 | |11;stanford-crypto-ccm;128;127;121;126;119;131;117;118;119;159 10:40:36 INFO - PID 4157 | |12;stanford-crypto-pbkdf2;171;175;169;171;172;170;171;172;173;175 10:40:36 INFO - PID 4157 | |13;stanford-crypto-sha256-iterative;62;65;60;61;68;62;61;66;61;60 10:40:36 INFO - PID 4157 | __end_tp_report 10:40:36 INFO - PID 4157 | __start_cc_report 10:40:36 INFO - PID 4157 | _x_x_mozilla_cycle_collect,801 10:40:36 INFO - PID 4157 | __end_cc_report 10:40:36 INFO - PID 4157 | __startTimestamp1500226836633__endTimestamp 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | ------- Summary: start ------- 10:40:36 INFO - PID 4157 | Number of tests: 14 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#0] ai-astar Cycles:10 Average:106.50 Median:108.00 stddev:3.54 (3.3%) stddev-sans-first:3.75 10:40:36 INFO - PID 4157 | Values: 107.0 97.0 108.0 108.0 105.0 109.0 107.0 109.0 107.0 108.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:20.32 (14.0%) stddev-sans-first:21.44 10:40:36 INFO - PID 4157 | Values: 146.0 115.0 143.0 173.0 120.0 151.0 144.0 116.0 166.0 127.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:3.18 (2.0%) stddev-sans-first:3.35 10:40:36 INFO - PID 4157 | Values: 162.0 162.0 162.0 164.0 161.0 171.0 163.0 160.0 160.0 164.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#3] audio-fft Cycles:10 Average:94.70 Median:74.50 stddev:43.00 (57.7%) stddev-sans-first:45.01 10:40:36 INFO - PID 4157 | Values: 75.0 76.0 73.0 188.0 74.0 75.0 74.0 74.0 163.0 75.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:80.50 stddev:23.82 (29.6%) stddev-sans-first:24.69 10:40:36 INFO - PID 4157 | Values: 81.0 80.0 136.0 80.0 81.0 80.0 124.0 82.0 81.0 129.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:40:36 INFO - PID 4157 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 114.0 113.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 10:40:36 INFO - PID 4157 | Values: 148.0 148.0 149.0 149.0 147.0 148.0 149.0 149.0 146.0 150.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 10:40:36 INFO - PID 4157 | Values: 95.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 96.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:48.50 stddev:1.43 (3.0%) stddev-sans-first:1.51 10:40:36 INFO - PID 4157 | Values: 49.0 47.0 47.0 48.0 48.0 51.0 50.0 48.0 47.0 50.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 10:40:36 INFO - PID 4157 | Values: 54.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 53.0 54.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:1.20 (1.6%) stddev-sans-first:1.27 10:40:36 INFO - PID 4157 | Values: 75.0 75.0 74.0 74.0 78.0 75.0 75.0 74.0 74.0 75.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.50 stddev:12.40 (9.8%) stddev-sans-first:13.14 10:40:36 INFO - PID 4157 | Values: 128.0 127.0 121.0 126.0 119.0 131.0 117.0 118.0 119.0 159.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.00 stddev:1.97 (1.1%) stddev-sans-first:2.06 10:40:36 INFO - PID 4157 | Values: 171.0 175.0 169.0 171.0 172.0 170.0 171.0 172.0 173.0 175.0 10:40:36 INFO - PID 4157 | 10:40:36 INFO - PID 4157 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:2.76 (4.4%) stddev-sans-first:2.92 10:40:36 INFO - PID 4157 | Values: 62.0 65.0 60.0 61.0 68.0 62.0 61.0 66.0 61.0 60.0 10:40:36 INFO - PID 4157 | -------- Summary: end -------- 10:40:36 INFO - PID 4157 | 10:40:37 INFO - PID 4157 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:40:37 INFO - TEST-INFO | 4157: exit 0 10:40:37 INFO - TEST-OK | kraken | took 60055ms 10:40:37 INFO - SUITE-END | took 1171s 10:40:37 INFO - Completed test suite (00:19:31) 10:40:37 INFO - javascript benchmark 10:40:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8751.402521471598, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.7985920844735, 3418.589769227693, 3433.6223015468295, 3442.466417705255, 3476.947845782314, 6146.323904370522, 6158.6612736299485, 6181.350958149397, 6182.567220294582, 6214.968925155374, 6257.186565746458, 6261.561690681654, 6268.247810262775, 6268.404501572355, 6277.246730392348, 5435.347758269013, 5442.047641662713, 5451.672899626015, 5460.31746031746, 5512.641678290918, 5411.377691565481, 5440.755166017519, 5450.100733378988, 5467.753951072212, 5469.863253418656, 5479.53423958964, 5480.287562616854, 5480.369757477902, 5481.698506582136, 5490.149026900836, 5480.91778623319, 5503.6147469677135, 5508.256385387961, 5515.0, 5515.669059856422, 5428.511433970962, 5475.288212532345, 5531.668099914018, 5535.197396377503, 5597.384287728347, 6197.628142311476, 6206.410391012847, 6267.0, 6269.7178626961895, 6277.905831412532, 6621.93378066218, 6706.899396509057, 6724.462043036546, 6733.528652994292, 6811.693473793691, 6683.93316066838, 6728.495362847806, 6748.19021717397, 6753.054572359824, 6756.864862702719, 6196.946519091765, 6219.0, 6238.563300568962, 6239.844003899893, 6252.624842509464, 6887.001384799226, 7000.334968178015, 7015.543989640657, 7079.398251148607, 7087.397571206505, 6620.66896655175, 6650.667466626746, 6662.900056499157, 6666.100076489709, 6752.696128674222, 6673.833154171088, 6774.966125169342, 6794.796156115324, 6848.897266541006, 6895.275996020346, 6619.106420633249, 6619.933800662028, 6637.46900247979, 6673.566218195899, 6717.294684058202, 6813.829654258584, 6818.454523638097, 6830.385265326145, 6876.17485901695, 6881.931180688229, 4945.134601444733, 5077.822276220315, 5122.308488354099, 5131.435542090367, 5158.0, 4423.712458690239, 4455.487618923865, 4463.24124898768, 4506.369108324837, 4603.470600880874, 6231.875362492816, 6258.624482531062, 6264.68676566179, 6270.31026587075, 6281.089242059968, 6650.102236198051, 6731.697073631698, 6746.898796518056, 6813.046173535709, 6817.113775209191, 6192.009278515506, 6194.38056194386, 6249.406306400884, 6254.593451425642, 6285.779997700059, 5672.688002159838, 5742.7702891883855, 5750.539956803445, 5759.65442073477, 5813.157092221604, 6931.792046238621, 6948.200956890022, 6952.478564107712, 6953.269906659728, 7039.260877607778, 6680.465562754968, 6730.528862979741, 6730.629815360202, 6735.393814556714, 6737.59574425536, 6986.47601429905, 6992.265812089658, 7010.649467526705, 7011.26381729911, 7020.859582808417, 6550.377714117151, 6628.734850605922, 6631.3700198481065, 6640.966795165993, 6660.500462465237, 6899.862002760017, 6917.377436030782, 6927.58434493932, 7029.789106326818, 7032.437405007689, 6637.502187335873, 6653.733850646114, 6726.596404215763, 6729.226138994079, 6763.458923286224, 6457.967710161419, 6629.207331943193, 6642.867142657216, 6732.528722989344, 6765.661716914036, 6202.7208775606105, 6552.312007239171, 6598.472122230306, 6615.867682646416, 6629.602223866584, 6629.7679581214425, 6639.103720997604, 6672.165979252593, 6713.12729345182, 6719.865602687821, 6324.051392291193, 6399.55203135776, 6484.967575162094, 6496.0580715795, 6521.706523206372], "value": 6152.598523338515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.6085940109094, 894.1790122851565, 910.3445519226158, 931.4644079654196, 932.1005229953103, 40224.396634050514, 40930.181396372056, 40934.79532602336, 41017.79491102548, 41107.17785644285, 37577.24845503088, 41788.0, 41854.0, 42262.78868605661, 42489.150216995644, 7195.172555156146, 7340.779776606711, 7379.335859772619, 7394.667239974214, 7400.851982960337, 7163.820904477378, 7298.52559583628, 7315.817104572375, 7322.597257150855, 7328.230535793745, 7332.450066245026, 7340.045794046767, 7356.411487081021, 7374.778756637309, 7375.557466552024, 7276.0, 7331.266873312653, 7346.706131754723, 7357.668904899238, 7361.4846960712775, 7171.9282807171785, 7188.604626745527, 7192.892106618405, 7222.891656625155, 7233.023541821839, 38287.42568861469, 38799.22401551953, 38880.22239555221, 39006.414903776466, 39035.21929561421, 3437.553118094657, 3463.9480407793903, 3472.5485686860798, 3477.3914564951288, 3489.825508724579, 30234.24414389658, 30294.242643934078, 30321.393572128654, 30418.695813041806, 30451.69548304533, 4760.071786001731, 4781.187198176319, 4937.284093806414, 4959.553640172366, 5003.17447621142, 196678.0, 196978.0, 232805.0, 241711.79144104343, 243872.0, 49484.0, 49520.0, 49619.75190124098, 49869.0, 49931.0, 50792.0, 51339.48660513422, 51375.48624513707, 51486.0, 51647.741761291705, 16500.83499165017, 16680.74978875318, 16731.91634041822, 16764.161791910356, 16773.329066837436, 13532.188068715908, 13565.186088834702, 13650.795238071438, 13714.51999180024, 13731.931340343235, 14648.780268295985, 14682.779758303634, 14710.852891471162, 14762.335694893542, 14837.183954882585, 5679.346875109332, 5750.539956803445, 5774.769009239667, 5895.823125306248, 6030.246219222598, 1081.551156270139, 1088.472091035847, 1091.5633746501462, 1115.4367044642404, 1115.6708770912437, 30549.08352749421, 30563.69436305653, 31570.684293157236, 31761.841190793897, 32005.199870003435, 1169.426980779412, 1185.266410805968, 1189.9647306842928, 1192.7554851255472, 1195.5397172088808, 13376.866231337757, 13410.329483525784, 13434.932825336005, 13452.596422107352, 13591.592252232449, 262432.0, 271307.0, 272254.0, 277250.0, 280881.0, 60012.99999999913, 60064.69967650134, 60339.39660603338, 60386.0, 60635.09047364293, 1494.0736743219275, 1506.8417816129368, 1523.512476007667, 1525.3212320517264, 1531.341523145036, 28664.426711466072, 29068.854655726587, 29390.853045734635, 29515.262118447212, 29546.409071818875, 39511.60488395079, 39577.80211098926, 39874.2025159501, 39963.80018099891, 45118.77440612776, 227431.0, 227854.0, 242053.0, 242436.0, 243890.0, 34202.82898585591, 34421.48367774535, 34561.30877382489, 34632.0, 38528.4956477828, 47999.76000119977, 48120.51879481161, 48170.759146204044, 48271.0, 48967.0, 32587.34825303433, 33309.29634621253, 34901.12747181341, 35178.0, 35195.82402087973, 33199.0, 33932.32135357329, 33963.830180848934, 34369.828150860085, 34392.656073439946, 40351.58769443056, 40731.38902916518, 40830.387544187455, 40838.18323633451, 40999.0, 31899.521507176945, 33462.4980625286, 34143.487847681805, 34319.656803431644, 34410.82794586011, 26243.73756262413, 26268.73731262663, 26271.343216419744, 26878.193654190407, 26895.462090757683], "value": 18116.62239027138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2240896358542, 574.4600075928627, 576.0926540698401, 581.5899790647593, 596.9253843269591, 21624.783752162475, 22962.540749185006, 23031.309060728163, 23142.53714925705, 23170.0, 25410.237692869196, 25849.74150258497, 26865.328366790793, 27008.594871076948, 27256.5911511327, 6217.564770466058, 6285.4971602271935, 6320.494360451153, 6334.144890439801, 6352.650604216767, 6228.19033525641, 6276.623402595836, 6277.2467303923595, 6278.497720182374, 6285.214348206474, 5740.339860915986, 6125.72434240458, 6231.40801623845, 6248.781292654758, 6260.029695397221, 5948.286205655306, 6042.214512113419, 6048.667323297217, 6057.454829065383, 6065.939340606582, 5627.593101724568, 5638.379778224433, 5648.237487939116, 5651.378348381716, 5668.376478587352, 29741.553876691865, 31686.524702129256, 32322.838385808154, 32357.191070223198, 32358.0, 2125.87244765313, 2161.7838216178416, 2167.1548096242477, 2169.1648715244587, 2174.3368272676826, 19402.80597194024, 20116.49708757278, 20205.191792328435, 20217.696734548994, 20235.595288094304, 2320.721513418384, 2377.9881100594557, 2381.38084098134, 2414.1188466209883, 2422.854628722265, 142150.0, 145890.0, 146592.0, 148944.0, 152206.0, 14771.704565908622, 15662.00618842188, 15664.451744189126, 15855.52433426999, 16064.357425703074, 24241.03035878545, 24275.271741847773, 24304.392390190034, 24349.63475547868, 24558.508829823302, 9473.715788526355, 9545.284103692251, 9553.90446095544, 9751.804963900682, 9758.951205243928, 8473.279771219391, 8475.788105297417, 8519.701810436729, 8530.0, 8636.611352489028, 9371.0, 9790.902090979142, 9792.902070979342, 9798.216142708567, 9825.115739583473, 2698.9730102699114, 2794.3153927287944, 2844.6586409630977, 2854.67171275306, 2888.046944508307, 1030.9742256443499, 1039.896010398954, 1044.9582016719398, 1076.8761592416815, 1078.2721662877527, 20644.69032964507, 21088.261910833047, 21336.893315533634, 21532.354029379145, 22061.448463788533, 1085.5603480590373, 1088.7985722641179, 1106.9282740395467, 1132.750794825137, 1138.117958582089, 11483.598074067368, 11783.705407364885, 11806.94096529529, 12062.457189426497, 12093.60923493792, 565041.0, 592292.0, 596291.0, 608768.0, 620323.0, 136606.0, 140683.0, 143607.2819635916, 143934.0, 145624.27187863993, 1301.6680746409795, 1313.343328335832, 1376.7040086381476, 1377.7657798174334, 1379.889608831311, 22275.888620556794, 22851.20020799264, 23145.421364466023, 23279.76720232776, 23373.181938632068, 64760.352396475435, 66628.66685666541, 66717.33282667305, 67164.3283567158, 68929.31070689228, 84747.5762621183, 85793.85515362165, 86534.1346586526, 86896.56551717201, 86994.56502717445, 14484.34820433062, 14584.854151458774, 14981.925090374914, 15114.244287785787, 15228.390864365301, 24201.51596968086, 24335.26994190177, 24424.0, 24669.87665061735, 24961.12636057729, 19861.0, 20017.29939452112, 20062.0, 20301.390958270684, 20454.181832726525, 17347.739783902998, 17380.70583105821, 17715.557111071812, 18145.637087258445, 18406.631867362845, 20354.59290814205, 20356.28752993638, 20414.285500007427, 20568.177272908917, 20638.17447302151, 14704.705905882036, 14934.626634334229, 15002.924985375003, 15063.322150503034, 15119.848801511844, 20474.38576842697, 20734.0, 20772.065257063772, 20829.270975515785, 20891.26880559173], "value": 12624.667086450225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.688988422547, 1437.223899094489, 1441.6756229848286, 1444.328387299906, 1484.7475929092057, 15101.546953591382, 15682.137482438462, 15785.342539033409, 15844.049357038586, 15888.126153061577, 15078.09531428115, 15499.690006199897, 15527.0, 15577.688446231068, 15599.1420471874, 2567.15283956294, 2610.5562054450693, 2618.384679600292, 2619.7511236432606, 2623.331050582108, 2605.9348516287055, 2676.37105280259, 2686.382132109616, 2698.662667166604, 2700.66241719785, 2577.1495406515805, 2596.9870150649313, 2614.1504011196344, 2619.6332513448133, 2621.4757048590263, 2515.207709571479, 2528.3679080229945, 2529.747025297474, 2531.1014589820534, 2545.096490745777, 2449.3998970252223, 2495.0643508684243, 2515.924522264335, 2517.2699917024224, 2519.722830488645, 14886.330115144845, 15087.170205638686, 15152.393904243818, 15242.161681107535, 15250.847491525054, 7779.144294127642, 8070.677172913076, 8072.0, 8075.434719569633, 8082.757517274491, 5110.488951104897, 5116.079105760961, 5195.870103247411, 5319.2287118368, 5320.893582128375, 1847.9815201848078, 1859.5258209156714, 1878.0797409269496, 1886.9811301886944, 1927.1231589626686, 23522.411939701644, 24136.87931560331, 26289.868550657317, 26550.6017409739, 26608.06871759479, 6050.969745151246, 6147.108669242934, 6667.299933506912, 6950.061741664912, 6967.825804354931, 18103.366382176562, 18202.54493637643, 18235.72646410305, 18245.178966946518, 18265.543361415806, 7680.231976802387, 8018.158093400226, 8036.638351274207, 8041.758747237593, 8072.515649061075, 7402.185759566443, 7413.4810563261135, 7419.517731347445, 7428.665710043061, 7485.0, 5234.842954711365, 5361.1422172453, 5405.567554595623, 5416.9729151353995, 5445.700486473282, 1422.559006707903, 1455.2432734977751, 1456.4829485532696, 1468.6181592785738, 1486.0786312486111, 901.3150005995491, 916.9495677737789, 938.7840796616816, 939.5302348825587, 945.5555888732284, 7870.606469676493, 7911.28798408146, 7939.483933544301, 7962.840743185104, 8001.679932802623, 737.2148661675299, 742.7808796405074, 762.4967521435826, 770.1220608506308, 782.8943092682529, 5056.797728090835, 5095.363079615048, 6003.369646187088, 6071.483923866521, 6317.305096439388, 21915.0, 22682.88658556697, 22699.432514187276, 22744.431389215402, 22782.0, 21293.46766330823, 21586.35240942774, 21606.567868642855, 22020.11919523233, 22024.0, 11338.773224535464, 11851.585194518151, 11935.403229838474, 12054.397280135958, 12367.876321236672, 8628.827423451621, 9161.679341223025, 9167.77080572991, 9319.813603727753, 9484.52577371115, 17801.73297400566, 18526.536836579195, 18832.24671013144, 19066.951317677107, 19703.507412314808, 17372.47882563525, 18947.43157705271, 19682.11430485603, 20066.89966550158, 20302.898485507478, 12214.450349734461, 12490.687732806753, 13059.34703264852, 13078.411471483996, 13131.803022954473, 14358.712825743636, 14526.636834079232, 14588.270586470846, 14667.633309167357, 14678.119312841263, 11255.155863310121, 11278.605248816251, 11403.885961140615, 11454.656360309204, 11794.705132371417, 10911.290766100177, 11257.099432045254, 11484.081273498266, 11661.24201926872, 11871.287722736663, 10175.643852465128, 10184.338018028804, 10184.338018028804, 10336.379817210991, 10368.274220804471, 7667.616619169131, 7740.651670674721, 7867.84264314722, 7883.132855385788, 7942.6028698566, 7692.807679808049, 7711.190325015793, 7785.688572457038, 7832.177621349904, 7832.255935686101], "value": 6726.580744311537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.6500379741778, 516.4422423782314, 528.2419727690764, 535.1410985368484, 535.7879512323618, 6061.7575296988125, 6149.231346081734, 6219.937800621992, 6239.937600623993, 6266.655333956631, 6001.549883758725, 6008.969955150229, 6061.605995610283, 6148.309214965887, 6180.314111017863, 4857.465678775332, 4873.488283730201, 4879.365682461275, 4887.291342755316, 4911.919377736892, 4841.56425921667, 4858.805647774085, 4864.270359446094, 4885.291632713254, 4894.3147959285725, 4777.614491797392, 4814.7351895645725, 4819.7590120494015, 4867.610591152717, 4878.65849390541, 4813.951860481386, 4827.0, 4867.4889136640495, 4900.338454308676, 4933.777979990909, 4132.710710250284, 4271.188474189894, 4279.1869544786705, 4444.133393988173, 4448.5773851484055, 5895.553345361713, 5914.674692891889, 5931.940680593182, 5965.343812180657, 6020.337762846083, 5654.6324488908085, 5655.434456554352, 5702.287214098238, 5713.514351280146, 5714.685342631351, 6504.447121994636, 6513.218413790328, 6553.3446655334565, 6603.504737144734, 6618.735250589971, 4913.434954980187, 4915.73876017029, 4922.80308787648, 4926.512111383764, 4930.728809915453, 6558.1802274715665, 6727.899081513781, 6874.312568743136, 6878.140232470942, 6981.2669669684965, 4914.845011422313, 5032.949670503248, 5047.343845300161, 5055.191169412877, 5064.11378008847, 5058.190689489664, 5099.770510327045, 5112.437631860493, 5121.897562048738, 5128.538431541105, 5621.325440947031, 5716.342620598684, 5745.2818397700285, 5747.655140691572, 5768.154190659033, 6581.736730530725, 6635.834104147339, 6642.6014439133805, 6652.933470665328, 6662.83342916431, 1759.9296028158985, 1760.119940029985, 1762.7884653841365, 1765.6203916158088, 1772.211365942169, 1165.0504838556549, 1223.467791510678, 1235.32057368447, 1235.8640549539543, 1241.3606992398923, 6073.48375388097, 6094.465210178175, 6135.478484328882, 6172.69136543171, 6196.938030619636, 6612.908870036486, 6658.400743932973, 6699.688607430428, 6707.66461676924, 6728.697208625624, 6071.787487437919, 6085.0, 6091.939080609137, 6106.542009349317, 6107.6640784757265, 3513.9648603514147, 3576.660217279354, 3589.8025608591256, 3590.1563132663805, 3610.6028336882923, 6886.276940921131, 6975.8604827903155, 7022.92670251253, 7035.401990830836, 7048.753293634698, 6790.72837086511, 6821.897671534931, 6858.485613579001, 6903.413209877217, 6939.583624982517, 7005.649717514206, 7014.562014787059, 7042.964785176041, 7050.294970502909, 7065.399441047466, 6103.3591472894705, 6651.104435235935, 6663.666816659051, 6742.393184613212, 6756.628385438848, 6531.967340163269, 6557.704903279268, 6562.278149403657, 6566.24488183865, 6570.685862827358, 6925.342092501204, 6965.373116419547, 7040.331168538981, 7046.894296585658, 7068.727629026825, 5020.397552293602, 5041.521055499722, 5049.57078648319, 5056.84829455117, 5072.923906141485, 6565.0, 6616.966915165393, 6673.499487538357, 6743.763968261087, 6762.222344430454, 6312.4634406076, 6365.745370185141, 6420.486361091008, 6484.286728459771, 6497.805065848032, 6427.260865000585, 6430.48556115519, 6484.481241500763, 6520.576162549419, 6562.80311590653, 6420.65166315079, 6545.672716364258, 6561.901571476336, 6568.967155164193, 6583.901241481286, 6543.214814222324, 6570.0, 6599.340065993362, 6603.80188594343, 6614.90077648826, 6400.519961003037, 6412.198475190601, 6412.39082287182, 6436.742530298736, 6470.191226096738], "value": 5083.083028684925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.081470566198, 944.5053302779714, 956.4452617481861, 961.7884065505586, 965.4159233663631, 14743.0, 14894.925525372359, 14928.552143435714, 14989.175595342265, 18070.0, 16128.274227659755, 16178.514644560653, 16355.345786168538, 17912.78882187972, 18201.544961375974, 1016.3089099412397, 1043.639944219243, 1044.8067107585084, 1048.4705223861938, 1052.763128296131, 1058.2856571814034, 1073.1897417449854, 1073.3613499967507, 1073.5759375046853, 1078.6170909327193, 1135.4663308245113, 1144.5193018932068, 1146.2950285574354, 1146.340854008944, 1146.8107762219265, 1009.0565321424418, 1079.5843600213896, 1124.7244425115816, 1133.9489722962446, 1139.5669645534686, 796.1918652567648, 801.7554645833019, 803.6704950970075, 807.1000834070028, 812.9878301514593, 18877.244910203575, 19033.143508542147, 19039.0, 19074.23703051876, 19109.713354299696, 19581.314653987185, 20153.596928061357, 20546.383608491768, 20776.68834967477, 20908.686369704315, 15998.680026399523, 16144.0, 16261.10563918984, 16395.836041639668, 16622.58443538909, 3118.251619611277, 3135.8745650173964, 3237.692419220194, 3242.1408326793417, 3268.7221586165206, 96515.0348496513, 135821.0, 139344.0, 140135.29932350272, 141214.0, 16521.91739041321, 16922.23849926756, 17138.228779704943, 17513.56216094608, 17593.208305626278, 30852.22869428282, 32033.51949720756, 32361.0, 32421.837890810395, 32459.35081298361, 9232.076792320715, 9284.0, 9289.44263344188, 9295.674651387304, 9296.209822165056, 4344.82620695175, 4408.470983482002, 4457.331400289982, 4457.398251236106, 4495.348174514677, 5374.838754837361, 5475.972620136953, 5493.7802487900035, 5501.559875209973, 5503.477169668875, 1088.689723428819, 1106.5573770491867, 1147.52377763229, 1148.74153315505, 1155.5089087137933, 677.806825054857, 682.1984168601873, 685.4447897203281, 707.2467821769799, 709.6912842913349, 12184.147109702235, 12508.687282818002, 12585.433655485525, 12802.487900483877, 12828.615141545768, 716.6631683108931, 727.9272072792784, 730.1709218407855, 734.9559026458429, 758.4198088462331, 5789.710514474259, 5866.208061911672, 5890.646561206256, 5947.583669143205, 6077.3314935357075, 119203.0, 123939.3803030979, 124364.0, 128000.35999819942, 130941.0, 110424.4478777601, 112848.0, 113392.43303783429, 116113.41943290399, 116919.41540292244, 98124.0, 98943.0, 100018.4999075, 101038.4948075255, 101058.49470752747, 12374.319412432402, 12538.868392373137, 12633.494660213488, 12739.363031848185, 13150.408231629408, 45910.77044614756, 46076.7696161517, 46757.29864051974, 47122.29316560323, 47875.76062119667, 54687.17969230544, 57256.42743572678, 57744.1338379933, 58119.0, 58963.41036589579, 15973.520794376187, 17388.0, 19508.609827803648, 19565.315213967442, 19946.501337466678, 20534.58930821405, 20788.896055519624, 21000.474988125417, 21650.783492164875, 22108.115675372806, 16804.495865124067, 17671.91164044223, 17703.29186832564, 18073.0, 19362.128704208062, 17900.91049544744, 18010.72983905269, 18239.0, 18514.16686249095, 18682.25270989145, 19450.8054919449, 19959.0, 20038.49903752418, 20062.49843753918, 20333.6949945748, 11713.1800773945, 12295.877041229473, 12421.44103515362, 12422.881940625388, 13216.207027578375, 12516.374181291081, 13091.345432728516, 13779.311034448037, 14147.64630884195, 15284.235788210322], "value": 9336.001881957744, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 97.0, 108.0, 108.0, 105.0, 109.0, 107.0, 109.0, 107.0, 108.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 115.0, 143.0, 173.0, 120.0, 151.0, 144.0, 116.0, 166.0, 127.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 164.0, 161.0, 171.0, 163.0, 160.0, 160.0, 164.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 188.0, 74.0, 75.0, 74.0, 74.0, 163.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 136.0, 80.0, 81.0, 80.0, 124.0, 82.0, 81.0, 129.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 149.0, 146.0, 150.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 47.0, 47.0, 48.0, 48.0, 51.0, 50.0, 48.0, 47.0, 50.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 78.0, 75.0, 75.0, 74.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 121.0, 126.0, 119.0, 131.0, 117.0, 118.0, 119.0, 159.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 169.0, 171.0, 172.0, 170.0, 171.0, 172.0, 173.0, 175.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 60.0, 61.0, 68.0, 62.0, 61.0, 66.0, 61.0, 60.0], "value": 62.6, "unit": "score"}]}]} 10:40:37 INFO - Return code: 0 10:40:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:40:37 INFO - # TBPL SUCCESS # 10:40:37 INFO - Running post-action listener: _package_coverage_data 10:40:37 INFO - Running post-action listener: _resource_record_post_action 10:40:37 INFO - [mozharness: 2017-07-16 17:40:37.913104Z] Finished run-tests step (success) 10:40:37 INFO - Running post-run listener: _resource_record_post_run 10:40:37 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 5611520; Write bytes: 440705024; Read time: 2232; Write time: 387676 10:40:37 INFO - TinderboxPrint: CPU usage
13.0% 10:40:37 INFO - TinderboxPrint: I/O read bytes / time
5,611,520 / 2,232 10:40:37 INFO - TinderboxPrint: I/O write bytes / time
440,705,024 / 387,676 10:40:37 INFO - TinderboxPrint: CPU idle
8,252.2 (87.0%) 10:40:37 INFO - TinderboxPrint: CPU user
1,186.9 (12.5%) 10:40:37 INFO - TinderboxPrint: Swap in / out
0 / 0 10:40:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120725504; Read time: 0; Write time: 114408 10:40:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:40:38 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 3379200; Write bytes: 319979520; Read time: 1992; Write time: 273268 10:40:38 INFO - Running post-run listener: _upload_blobber_files 10:40:38 INFO - Blob upload gear active. 10:40:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:40:38 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 10:40:38 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'] 10:40:38 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 10:40:38 INFO - Traceback (most recent call last): 10:40:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 10:40:38 INFO - main() 10:40:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 10:40:38 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 10:40:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 10:40:38 INFO - return set(response.json().get('whitelist', [])) 10:40:38 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 10:40:38 INFO - return json.loads(self.text or self.content, **kwargs) 10:40:38 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 10:40:38 INFO - return _default_decoder.decode(s) 10:40:38 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 10:40:38 INFO - obj, end = self.raw_decode(s) 10:40:38 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 10:40:38 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 10:40:38 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 10:40:38 ERROR - Return code: 1 10:40:38 INFO - Setting buildbot property blobber_files to {} 10:40:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:40:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:40:38 INFO - Contents: 10:40:38 INFO - blobber_files:{} 10:40:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:40:38 INFO - Copying logs to upload dir... 10:40:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:40:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.315553 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-16 10:40:38.975943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 10:40:38.979955) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/KSq8SEQpR5iD7VvyeLx3VA/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 10:40:39.031949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:40:39.032314) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1500224631.26755-1868991489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:40:39.082794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 10:40:39.083150) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 10:40:39.083493) ========= ========= Total master_lag: 0.15 =========