builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1500252690.02 results: success (0) revision: aff336ac161daa3ea350e59a288963edbd58ed39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.019305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.019803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.020123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.107369) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.107660) ========= 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=41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 17:51:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-07-16 17:51:30 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125974 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.273480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.273810) ========= 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=41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.068916 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.352932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:30.353231) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aff336ac161daa3ea350e59a288963edbd58ed39 --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 aff336ac161daa3ea350e59a288963edbd58ed39 --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=41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 17:51:30,462 truncating revision to first 12 chars 2017-07-16 17:51:30,462 Setting DEBUG logging. 2017-07-16 17:51:30,462 attempt 1/10 2017-07-16 17:51:30,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aff336ac161d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 17:51:30,919 unpacking tar archive at: mozilla-central-aff336ac161d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:31.144627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:31.144936) ========= script_repo_revision: aff336ac161daa3ea350e59a288963edbd58ed39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:31.145308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:31.145847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:31.154238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-16 17:51:31.154697) ========= /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=41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:51:31 INFO - MultiFileLogger online at 20170716 17:51:31 in /builds/slave/test 17:51:31 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 17:51:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:51:31 INFO - {'append_to_log': False, 17:51:31 INFO - 'base_work_dir': '/builds/slave/test', 17:51:31 INFO - 'blob_upload_branch': 'Firefox', 17:51:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:51:31 INFO - 'branch': 'Firefox', 17:51:31 INFO - 'buildbot_json_path': 'buildprops.json', 17:51:31 INFO - 'code_coverage': False, 17:51:31 INFO - 'config_files': ('talos/linux_config.py',), 17:51:31 INFO - 'default_actions': ('clobber', 17:51:31 INFO - 'read-buildbot-config', 17:51:31 INFO - 'download-and-extract', 17:51:31 INFO - 'populate-webroot', 17:51:31 INFO - 'create-virtualenv', 17:51:31 INFO - 'install', 17:51:31 INFO - 'setup-mitmproxy', 17:51:31 INFO - 'run-tests'), 17:51:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:51:31 INFO - 'disable_ccov_upload': False, 17:51:31 INFO - 'download_minidump_stackwalk': True, 17:51:31 INFO - 'download_symbols': 'ondemand', 17:51:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:51:31 INFO - 'tooltool.py': '/tools/tooltool.py', 17:51:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:51:31 INFO - '/tools/misc-python/virtualenv.py')}, 17:51:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:51:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:51:31 INFO - 'gecko_profile': False, 17:51:31 INFO - 'gecko_profile_interval': 0, 17:51:31 INFO - 'installer_path': 'installer.exe', 17:51:31 INFO - 'log_level': 'info', 17:51:31 INFO - 'log_name': 'talos', 17:51:31 INFO - 'log_to_console': True, 17:51:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:51:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:51:31 INFO - 'opt_config_files': (), 17:51:31 INFO - 'pip_index': False, 17:51:31 INFO - 'suite': 'dromaeojs-e10s', 17:51:31 INFO - 'system_bits': '32', 17:51:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:51:31 INFO - 'title': 'talos-linux64-ix-026', 17:51:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:51:31 INFO - 'use_talos_json': True, 17:51:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:51:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:51:31 INFO - 'work_dir': 'build'} 17:51:31 INFO - [mozharness: 2017-07-17 00:51:31.481063Z] Running clobber step. 17:51:31 INFO - Running pre-action listener: _resource_record_pre_action 17:51:31 INFO - Running main action method: clobber 17:51:31 INFO - rmtree: /builds/slave/test/build 17:51:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:51:36 INFO - Running post-action listener: _resource_record_post_action 17:51:36 INFO - [mozharness: 2017-07-17 00:51:36.883063Z] Finished clobber step (success) 17:51:36 INFO - [mozharness: 2017-07-17 00:51:36.883203Z] Running read-buildbot-config step. 17:51:36 INFO - Running pre-action listener: _resource_record_pre_action 17:51:36 INFO - Running main action method: read_buildbot_config 17:51:36 INFO - Using buildbot properties: 17:51:36 INFO - { 17:51:36 INFO - "project": "", 17:51:36 INFO - "product": "firefox", 17:51:36 INFO - "who": "nnethercote@mozilla.com", 17:51:36 INFO - "installer_path": "public/build/target.tar.bz2", 17:51:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:51:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:51:36 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:51:36 INFO - "stage_platform": "linux64-stylo", 17:51:36 INFO - "basedir": "/builds/slave/test", 17:51:36 INFO - "buildnumber": 214, 17:51:36 INFO - "platform": "ubuntu64_hw_stylo", 17:51:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:51:36 INFO - "slavebuilddir": "test", 17:51:36 INFO - "taskId": "CreLAMmkR86thafUnM8V0A", 17:51:36 INFO - "branch": "mozilla-central", 17:51:36 INFO - "script_repo_revision": "production", 17:51:36 INFO - "revision": "aff336ac161daa3ea350e59a288963edbd58ed39", 17:51:36 INFO - "slavename": "talos-linux64-ix-026", 17:51:36 INFO - "repo_path": "mozilla-central" 17:51:36 INFO - } 17:51:36 INFO - Finding installer, test and symbols from parent task. 17:51:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CreLAMmkR86thafUnM8V0A'}, attempt #1 17:51:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CreLAMmkR86thafUnM8V0A'}, attempt #1 17:51:37 INFO - Task dependencies: NrNICH0tQbmyluaBowvvdg 17:51:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg'}, attempt #1 17:51:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:51:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/test_packages.json 17:51:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip 17:51:38 INFO - Running post-action listener: _resource_record_post_action 17:51:38 INFO - [mozharness: 2017-07-17 00:51:38.214386Z] Finished read-buildbot-config step (success) 17:51:38 INFO - [mozharness: 2017-07-17 00:51:38.214610Z] Running download-and-extract step. 17:51:38 INFO - Running pre-action listener: _resource_record_pre_action 17:51:38 INFO - Running main action method: download_and_extract 17:51:38 INFO - mkdir: /builds/slave/test/build/tests 17:51: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')]} 17:51:38 INFO - trying https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.test_packages.json 17:51:38 INFO - Downloading https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:51:38 INFO - Downloaded 989 bytes. 17:51:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:51:38 INFO - Using the following test package requirements: 17:51:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:51:38 INFO - u'common': [u'target.common.tests.zip'], 17:51:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:51:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:51:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:51:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:51:38 INFO - u'mozbase': [u'target.common.tests.zip'], 17:51:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:51:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:51:38 INFO - u'web-platform': [u'target.common.tests.zip', 17:51:38 INFO - u'target.web-platform.tests.tar.gz'], 17:51:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:51:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:51:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip 17:51:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:51:38 INFO - Fetch https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip into memory 17:51:39 INFO - Content-Length response header: 72769114 17:51:39 INFO - Bytes received: 72769114 17:51:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:51:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip 17:51:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:51:51 INFO - Fetch https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip into memory 17:51:52 INFO - Content-Length response header: 72769114 17:51:52 INFO - Bytes received: 72769114 17:52:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.talos.tests.zip 17:52:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:52:05 INFO - Fetch https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.talos.tests.zip into memory 17:52:06 INFO - Content-Length response header: 14495033 17:52:06 INFO - Bytes received: 14495033 17:52:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:06 INFO - trying https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:52:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:52:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:52:07 INFO - Downloaded 61824462 bytes. 17:52:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:52:07 INFO - mkdir: /builds/slave/test/properties 17:52:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:52:07 INFO - Writing to file /builds/slave/test/properties/build_url 17:52:07 INFO - Contents: 17:52:07 INFO - build_url:https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:52:07 INFO - Running post-action listener: _resource_record_post_action 17:52:07 INFO - Running post-action listener: set_extra_try_arguments 17:52:07 INFO - [mozharness: 2017-07-17 00:52:07.688082Z] Finished download-and-extract step (success) 17:52:07 INFO - [mozharness: 2017-07-17 00:52:07.688180Z] Running populate-webroot step. 17:52:07 INFO - Running pre-action listener: _resource_record_pre_action 17:52:07 INFO - Running main action method: populate_webroot 17:52:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:52:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:52:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:52:07 INFO - '--tppagecycles', 17:52:07 INFO - '7'], 17:52:07 INFO - 'tests': ['tsvgm']}}, 17:52:07 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:52:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:52:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:52:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['damp', 'tps']}, 17:52:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'tests': ['damp', 'tps']}, 17:52:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['dromaeo_dom']}, 17:52:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:52:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:52:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:52:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:52:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['a11yr', 17:52:07 INFO - 'ts_paint', 17:52:07 INFO - 'tpaint', 17:52:07 INFO - 'sessionrestore', 17:52:07 INFO - 'sessionrestore_no_auto_restore', 17:52:07 INFO - 'tabpaint']}, 17:52:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:52:07 INFO - 'ts_paint', 17:52:07 INFO - 'tpaint', 17:52:07 INFO - 'sessionrestore', 17:52:07 INFO - 'sessionrestore_many_windows', 17:52:07 INFO - 'sessionrestore_no_auto_restore', 17:52:07 INFO - 'tabpaint']}, 17:52:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:52:07 INFO - 'ts_paint', 17:52:07 INFO - 'tpaint', 17:52:07 INFO - 'sessionrestore', 17:52:07 INFO - 'sessionrestore_many_windows', 17:52:07 INFO - 'sessionrestore_no_auto_restore', 17:52:07 INFO - 'tabpaint']}, 17:52:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:52:07 INFO - 'ts_paint', 17:52:07 INFO - 'tpaint', 17:52:07 INFO - 'sessionrestore', 17:52:07 INFO - 'sessionrestore_many_windows', 17:52:07 INFO - 'sessionrestore_no_auto_restore', 17:52:07 INFO - 'tabpaint']}, 17:52:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['a11yr', 17:52:07 INFO - 'ts_paint', 17:52:07 INFO - 'tpaint', 17:52:07 INFO - 'sessionrestore', 17:52:07 INFO - 'sessionrestore_no_auto_restore', 17:52:07 INFO - 'tabpaint']}, 17:52:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['a11yr', 17:52:07 INFO - 'ts_paint', 17:52:07 INFO - 'tpaint', 17:52:07 INFO - 'sessionrestore', 17:52:07 INFO - 'sessionrestore_no_auto_restore', 17:52:07 INFO - 'tabpaint']}, 17:52:07 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:52:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:52:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:52:07 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:52:07 INFO - 'talos_options': ['--mitmproxy', 17:52:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:52:07 INFO - '--firstNonBlankPaint'], 17:52:07 INFO - 'tests': ['quantum_pageload_google', 17:52:07 INFO - 'quantum_pageload_youtube', 17:52:07 INFO - 'quantum_pageload_amazon', 17:52:07 INFO - 'quantum_pageload_facebook']}, 17:52:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['tsvgx', 17:52:07 INFO - 'tsvgr_opacity', 17:52:07 INFO - 'tart', 17:52:07 INFO - 'tscrollx', 17:52:07 INFO - 'cart', 17:52:07 INFO - 'tsvg_static']}, 17:52:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:52:07 INFO - 'tsvgr_opacity', 17:52:07 INFO - 'tart', 17:52:07 INFO - 'tscrollx', 17:52:07 INFO - 'cart', 17:52:07 INFO - 'tsvg_static']}, 17:52:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'talos_options': ['--disable-e10s'], 17:52:07 INFO - 'tests': ['tp5o']}, 17:52:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:52:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'talos_options': ['--disable-e10s', 17:52:07 INFO - '--xperf_path', 17:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:07 INFO - 'tests': ['tp5n']}, 17:52:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:52:07 INFO - 'talos_options': ['--xperf_path', 17:52:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:07 INFO - 'tests': ['tp5n']}}, 17:52:07 INFO - 'talos.zip': {'path': '', 17:52:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:52:07 INFO - Running post-action listener: _resource_record_post_action 17:52:07 INFO - [mozharness: 2017-07-17 00:52:07.703501Z] Finished populate-webroot step (success) 17:52:07 INFO - [mozharness: 2017-07-17 00:52:07.703592Z] Running create-virtualenv step. 17:52:07 INFO - Running pre-action listener: _resource_record_pre_action 17:52:07 INFO - Running main action method: create_virtualenv 17:52:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:52:07 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 17:52:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:52:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:52:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:52:07 INFO - Using real prefix '/usr' 17:52:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:52:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:52:10 INFO - Installing pip.................done. 17:52:10 INFO - Return code: 0 17:52:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:52:10 INFO - Reading from file tmpfile_stdout 17:52:10 INFO - Output received: 17:52:10 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) 17:52:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:52:10 INFO - Using env: {'DISPLAY': ':0', 17:52:10 INFO - 'HOME': '/home/cltbld', 17:52:10 INFO - 'LANG': 'en_US.UTF-8', 17:52:10 INFO - 'LANGUAGE': 'en_US:en', 17:52:10 INFO - 'LOGNAME': 'cltbld', 17:52:10 INFO - 'MAIL': '/var/mail/cltbld', 17:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:10 INFO - 'MOZ_NO_REMOTE': '1', 17:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:10 INFO - 'NO_EM_RESTART': '1', 17:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:10 INFO - 'PWD': '/builds/slave/test', 17:52:10 INFO - 'SHELL': '/bin/bash', 17:52:10 INFO - 'SHLVL': '1', 17:52:10 INFO - 'TERM': 'linux', 17:52:10 INFO - 'TMOUT': '86400', 17:52:10 INFO - 'USER': 'cltbld', 17:52:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:10 INFO - '_': '/tools/buildbot/bin/python'} 17:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:10 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 17:52:10 INFO - Cleaning up... 17:52:10 INFO - Return code: 0 17:52:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:52:10 INFO - Using env: {'DISPLAY': ':0', 17:52:10 INFO - 'HOME': '/home/cltbld', 17:52:10 INFO - 'LANG': 'en_US.UTF-8', 17:52:10 INFO - 'LANGUAGE': 'en_US:en', 17:52:10 INFO - 'LOGNAME': 'cltbld', 17:52:10 INFO - 'MAIL': '/var/mail/cltbld', 17:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:10 INFO - 'MOZ_NO_REMOTE': '1', 17:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:10 INFO - 'NO_EM_RESTART': '1', 17:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:10 INFO - 'PWD': '/builds/slave/test', 17:52:10 INFO - 'SHELL': '/bin/bash', 17:52:10 INFO - 'SHLVL': '1', 17:52:10 INFO - 'TERM': 'linux', 17:52:10 INFO - 'TMOUT': '86400', 17:52:10 INFO - 'USER': 'cltbld', 17:52:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:10 INFO - '_': '/tools/buildbot/bin/python'} 17:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:11 INFO - Downloading/unpacking psutil>=3.1.1 17:52:11 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 17:52:11 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 17:52:11 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 17:52:11 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 17:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:52:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:52:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:52:12 INFO - Installing collected packages: psutil 17:52:12 INFO - Running setup.py install for psutil 17:52:12 INFO - building 'psutil._psutil_linux' extension 17:52:12 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 17:52:13 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 17:52:13 INFO - building 'psutil._psutil_posix' extension 17:52:13 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 17:52:13 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 17:52:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:52:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:52:13 INFO - Successfully installed psutil 17:52:13 INFO - Cleaning up... 17:52:14 INFO - Return code: 0 17:52:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:52:14 INFO - Using env: {'DISPLAY': ':0', 17:52:14 INFO - 'HOME': '/home/cltbld', 17:52:14 INFO - 'LANG': 'en_US.UTF-8', 17:52:14 INFO - 'LANGUAGE': 'en_US:en', 17:52:14 INFO - 'LOGNAME': 'cltbld', 17:52:14 INFO - 'MAIL': '/var/mail/cltbld', 17:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:14 INFO - 'MOZ_NO_REMOTE': '1', 17:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:14 INFO - 'NO_EM_RESTART': '1', 17:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:14 INFO - 'PWD': '/builds/slave/test', 17:52:14 INFO - 'SHELL': '/bin/bash', 17:52:14 INFO - 'SHLVL': '1', 17:52:14 INFO - 'TERM': 'linux', 17:52:14 INFO - 'TMOUT': '86400', 17:52:14 INFO - 'USER': 'cltbld', 17:52:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:14 INFO - '_': '/tools/buildbot/bin/python'} 17:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:52:15 INFO - Installing collected packages: mozsystemmonitor 17:52:15 INFO - Running setup.py install for mozsystemmonitor 17:52:15 INFO - Successfully installed mozsystemmonitor 17:52:15 INFO - Cleaning up... 17:52:15 INFO - Return code: 0 17:52:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:15 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:15 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 17:52:15 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 17:52:15 INFO - Using env: {'DISPLAY': ':0', 17:52:15 INFO - 'HOME': '/home/cltbld', 17:52:15 INFO - 'LANG': 'en_US.UTF-8', 17:52:15 INFO - 'LANGUAGE': 'en_US:en', 17:52:15 INFO - 'LOGNAME': 'cltbld', 17:52:15 INFO - 'MAIL': '/var/mail/cltbld', 17:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:15 INFO - 'MOZ_NO_REMOTE': '1', 17:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:15 INFO - 'NO_EM_RESTART': '1', 17:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:15 INFO - 'PWD': '/builds/slave/test', 17:52:15 INFO - 'SHELL': '/bin/bash', 17:52:15 INFO - 'SHLVL': '1', 17:52:15 INFO - 'TERM': 'linux', 17:52:15 INFO - 'TMOUT': '86400', 17:52:15 INFO - 'USER': 'cltbld', 17:52:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:15 INFO - '_': '/tools/buildbot/bin/python'} 17:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:15 INFO - Downloading/unpacking jsonschema==2.5.1 17:52:15 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 17:52:15 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 17:52:15 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 17:52:15 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 17:52:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:52:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:16 INFO - Downloading functools32-3.2.3-2.tar.gz 17:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:52:16 INFO - warning: no files found matching '*.txt' 17:52:16 INFO - no previously-included directories found matching 'build' 17:52:16 INFO - no previously-included directories found matching 'dist' 17:52:16 INFO - no previously-included directories found matching '.git*' 17:52:16 INFO - Installing collected packages: jsonschema, functools32 17:52:17 INFO - Running setup.py install for functools32 17:52:17 INFO - warning: no files found matching '*.txt' 17:52:17 INFO - no previously-included directories found matching 'build' 17:52:17 INFO - no previously-included directories found matching 'dist' 17:52:17 INFO - no previously-included directories found matching '.git*' 17:52:17 INFO - Successfully installed jsonschema functools32 17:52:17 INFO - Cleaning up... 17:52:17 INFO - Return code: 0 17:52:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:17 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:17 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 17:52:17 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 17:52:17 INFO - Using env: {'DISPLAY': ':0', 17:52:17 INFO - 'HOME': '/home/cltbld', 17:52:17 INFO - 'LANG': 'en_US.UTF-8', 17:52:17 INFO - 'LANGUAGE': 'en_US:en', 17:52:17 INFO - 'LOGNAME': 'cltbld', 17:52:17 INFO - 'MAIL': '/var/mail/cltbld', 17:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:17 INFO - 'MOZ_NO_REMOTE': '1', 17:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:17 INFO - 'NO_EM_RESTART': '1', 17:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:17 INFO - 'PWD': '/builds/slave/test', 17:52:17 INFO - 'SHELL': '/bin/bash', 17:52:17 INFO - 'SHLVL': '1', 17:52:17 INFO - 'TERM': 'linux', 17:52:17 INFO - 'TMOUT': '86400', 17:52:17 INFO - 'USER': 'cltbld', 17:52:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:17 INFO - '_': '/tools/buildbot/bin/python'} 17:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:52:17 INFO - Cleaning up... 17:52:17 INFO - Return code: 0 17:52:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:17 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:17 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 17:52:17 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 17:52:17 INFO - Using env: {'DISPLAY': ':0', 17:52:17 INFO - 'HOME': '/home/cltbld', 17:52:17 INFO - 'LANG': 'en_US.UTF-8', 17:52:17 INFO - 'LANGUAGE': 'en_US:en', 17:52:17 INFO - 'LOGNAME': 'cltbld', 17:52:17 INFO - 'MAIL': '/var/mail/cltbld', 17:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:17 INFO - 'MOZ_NO_REMOTE': '1', 17:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:17 INFO - 'NO_EM_RESTART': '1', 17:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:17 INFO - 'PWD': '/builds/slave/test', 17:52:17 INFO - 'SHELL': '/bin/bash', 17:52:17 INFO - 'SHLVL': '1', 17:52:17 INFO - 'TERM': 'linux', 17:52:17 INFO - 'TMOUT': '86400', 17:52:17 INFO - 'USER': 'cltbld', 17:52:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:17 INFO - '_': '/tools/buildbot/bin/python'} 17:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:17 INFO - Downloading/unpacking blobuploader==1.2.4 17:52:17 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 17:52:17 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 17:52:17 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 17:52:17 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 17:52:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:52:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:52:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:52:19 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 17:52:19 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 17:52:19 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 17:52:19 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 17:52:19 INFO - Downloading docopt-0.6.1.tar.gz 17:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:52:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:52:19 INFO - Running setup.py install for blobuploader 17:52:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:52:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:52:19 INFO - Running setup.py install for requests 17:52:19 INFO - Running setup.py install for docopt 17:52:19 INFO - Successfully installed blobuploader requests docopt 17:52:19 INFO - Cleaning up... 17:52:19 INFO - Return code: 0 17:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:19 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:19 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 17:52:19 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 17:52:19 INFO - Using env: {'DISPLAY': ':0', 17:52:19 INFO - 'HOME': '/home/cltbld', 17:52:19 INFO - 'LANG': 'en_US.UTF-8', 17:52:19 INFO - 'LANGUAGE': 'en_US:en', 17:52:19 INFO - 'LOGNAME': 'cltbld', 17:52:19 INFO - 'MAIL': '/var/mail/cltbld', 17:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:19 INFO - 'MOZ_NO_REMOTE': '1', 17:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:19 INFO - 'NO_EM_RESTART': '1', 17:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:19 INFO - 'PWD': '/builds/slave/test', 17:52:19 INFO - 'SHELL': '/bin/bash', 17:52:19 INFO - 'SHLVL': '1', 17:52:19 INFO - 'TERM': 'linux', 17:52:19 INFO - 'TMOUT': '86400', 17:52:19 INFO - 'USER': 'cltbld', 17:52:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:19 INFO - '_': '/tools/buildbot/bin/python'} 17:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:20 INFO - Running setup.py (path:/tmp/pip-FETYV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:20 INFO - Running setup.py (path:/tmp/pip-CDFAph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:20 INFO - Running setup.py (path:/tmp/pip-VvIawo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:20 INFO - Running setup.py (path:/tmp/pip-j9kR3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:20 INFO - Running setup.py (path:/tmp/pip-nCUevY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:20 INFO - Running setup.py (path:/tmp/pip-fZ3JEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:20 INFO - Running setup.py (path:/tmp/pip-dnU35K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:20 INFO - Running setup.py (path:/tmp/pip-QUyyxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:20 INFO - Running setup.py (path:/tmp/pip-GRRcOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:20 INFO - Running setup.py (path:/tmp/pip-ckkLFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:20 INFO - Running setup.py (path:/tmp/pip-ayPie_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:20 INFO - Running setup.py (path:/tmp/pip-ci8KvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:20 INFO - Running setup.py (path:/tmp/pip-aabcTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:21 INFO - Running setup.py (path:/tmp/pip-nPAZCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:21 INFO - Running setup.py (path:/tmp/pip-0UJsWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:21 INFO - Running setup.py (path:/tmp/pip-DNGULm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:21 INFO - Running setup.py (path:/tmp/pip-g2PB8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:52:21 INFO - Running setup.py install for manifestparser 17:52:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:52:21 INFO - Running setup.py install for mozcrash 17:52:21 INFO - Running setup.py install for mozdebug 17:52:21 INFO - Running setup.py install for mozdevice 17:52:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:52:21 INFO - Running setup.py install for mozfile 17:52:21 INFO - Running setup.py install for mozhttpd 17:52:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:52:21 INFO - Running setup.py install for mozinfo 17:52:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:52:21 INFO - Running setup.py install for mozInstall 17:52:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Running setup.py install for mozleak 17:52:22 INFO - Running setup.py install for mozlog 17:52:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Running setup.py install for moznetwork 17:52:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Running setup.py install for mozprocess 17:52:22 INFO - Running setup.py install for mozprofile 17:52:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Running setup.py install for mozrunner 17:52:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:52:22 INFO - Running setup.py install for mozscreenshot 17:52:22 INFO - Running setup.py install for moztest 17:52:22 INFO - Running setup.py install for mozversion 17:52:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:52:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:52:23 INFO - Cleaning up... 17:52:23 INFO - Return code: 0 17:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:23 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:23 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 17:52:23 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 17:52:23 INFO - Using env: {'DISPLAY': ':0', 17:52:23 INFO - 'HOME': '/home/cltbld', 17:52:23 INFO - 'LANG': 'en_US.UTF-8', 17:52:23 INFO - 'LANGUAGE': 'en_US:en', 17:52:23 INFO - 'LOGNAME': 'cltbld', 17:52:23 INFO - 'MAIL': '/var/mail/cltbld', 17:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:23 INFO - 'MOZ_NO_REMOTE': '1', 17:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:23 INFO - 'NO_EM_RESTART': '1', 17:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:23 INFO - 'PWD': '/builds/slave/test', 17:52:23 INFO - 'SHELL': '/bin/bash', 17:52:23 INFO - 'SHLVL': '1', 17:52:23 INFO - 'TERM': 'linux', 17:52:23 INFO - 'TMOUT': '86400', 17:52:23 INFO - 'USER': 'cltbld', 17:52:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:23 INFO - '_': '/tools/buildbot/bin/python'} 17:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:23 INFO - Running setup.py (path:/tmp/pip-WQBOcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:23 INFO - Running setup.py (path:/tmp/pip-78MAiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:23 INFO - Running setup.py (path:/tmp/pip-lDEN2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:23 INFO - Running setup.py (path:/tmp/pip-efbKX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:23 INFO - Running setup.py (path:/tmp/pip-QbXKrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:23 INFO - Running setup.py (path:/tmp/pip-_2Uscv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:23 INFO - Running setup.py (path:/tmp/pip-6EqjBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:23 INFO - Running setup.py (path:/tmp/pip-imlyOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:23 INFO - Running setup.py (path:/tmp/pip-A7oBCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:23 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)) 17:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:23 INFO - Running setup.py (path:/tmp/pip-mLBsJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:24 INFO - Running setup.py (path:/tmp/pip-76Hbhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:24 INFO - Running setup.py (path:/tmp/pip-xoS6yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:24 INFO - Running setup.py (path:/tmp/pip-Filrqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:24 INFO - Running setup.py (path:/tmp/pip-AADT8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:24 INFO - Running setup.py (path:/tmp/pip-xV4qK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:24 INFO - Running setup.py (path:/tmp/pip-0Y3ggI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:24 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)) 17:52:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:24 INFO - Running setup.py (path:/tmp/pip-vs4Vp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:24 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)) 17:52:24 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)) 17:52:24 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)) 17:52:24 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)) 17:52:24 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)) 17:52:24 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)) 17:52:24 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)) 17:52:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:52:24 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 17:52:24 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 17:52:24 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 17:52:24 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 17:52:25 INFO - Downloading blessings-1.6.tar.gz 17:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:52:25 INFO - Installing collected packages: blessings 17:52:25 INFO - Running setup.py install for blessings 17:52:25 INFO - Successfully installed blessings 17:52:25 INFO - Cleaning up... 17:52:25 INFO - Return code: 0 17:52:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:52:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:26 INFO - Reading from file tmpfile_stdout 17:52:26 INFO - Current package versions: 17:52:26 INFO - argparse == 1.2.1 17:52:26 INFO - blessings == 1.6 17:52:26 INFO - blobuploader == 1.2.4 17:52:26 INFO - docopt == 0.6.1 17:52:26 INFO - functools32 == 3.2.3-2 17:52:26 INFO - jsonschema == 2.5.1 17:52:26 INFO - manifestparser == 1.1 17:52:26 INFO - mozInstall == 1.13 17:52:26 INFO - mozcrash == 1.0 17:52:26 INFO - mozdebug == 0.1 17:52:26 INFO - mozdevice == 0.51 17:52:26 INFO - mozfile == 1.2 17:52:26 INFO - mozhttpd == 0.7 17:52:26 INFO - mozinfo == 0.10 17:52:26 INFO - mozleak == 0.1 17:52:26 INFO - mozlog == 3.5 17:52:26 INFO - moznetwork == 0.27 17:52:26 INFO - mozprocess == 0.25 17:52:26 INFO - mozprofile == 0.28 17:52:26 INFO - mozrunner == 6.13 17:52:26 INFO - mozscreenshot == 0.1 17:52:26 INFO - mozsystemmonitor == 0.3 17:52:26 INFO - moztest == 0.8 17:52:26 INFO - mozversion == 1.4 17:52:26 INFO - psutil == 3.1.1 17:52:26 INFO - requests == 1.2.3 17:52:26 INFO - wsgiref == 0.1.2 17:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:26 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:26 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 17:52:26 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 17:52:26 INFO - Using env: {'DISPLAY': ':0', 17:52:26 INFO - 'HOME': '/home/cltbld', 17:52:26 INFO - 'LANG': 'en_US.UTF-8', 17:52:26 INFO - 'LANGUAGE': 'en_US:en', 17:52:26 INFO - 'LOGNAME': 'cltbld', 17:52:26 INFO - 'MAIL': '/var/mail/cltbld', 17:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:26 INFO - 'MOZ_NO_REMOTE': '1', 17:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:26 INFO - 'NO_EM_RESTART': '1', 17:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:26 INFO - 'PWD': '/builds/slave/test', 17:52:26 INFO - 'SHELL': '/bin/bash', 17:52:26 INFO - 'SHLVL': '1', 17:52:26 INFO - 'TERM': 'linux', 17:52:26 INFO - 'TMOUT': '86400', 17:52:26 INFO - 'USER': 'cltbld', 17:52:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:26 INFO - '_': '/tools/buildbot/bin/python'} 17:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 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)) 17:52:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:52:26 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 17:52:26 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 17:52:26 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 17:52:26 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 17:52:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:52:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:52:27 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 17:52:27 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 17:52:27 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 17:52:27 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 17:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:52:27 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)) 17:52:27 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)) 17:52:27 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)) 17:52:27 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)) 17:52:27 INFO - Installing collected packages: marionette-driver, simplejson 17:52:27 INFO - Running setup.py install for marionette-driver 17:52:27 INFO - Running setup.py install for simplejson 17:52:27 INFO - building 'simplejson._speedups' extension 17:52:27 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 17:52:28 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 17:52:28 INFO - Successfully installed marionette-driver simplejson 17:52:28 INFO - Cleaning up... 17:52:28 INFO - Return code: 0 17:52:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:28 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 0x103a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1206a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13abb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, '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': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', '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 17:52:28 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 17:52:28 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 17:52:28 INFO - Using env: {'DISPLAY': ':0', 17:52:28 INFO - 'HOME': '/home/cltbld', 17:52:28 INFO - 'LANG': 'en_US.UTF-8', 17:52:28 INFO - 'LANGUAGE': 'en_US:en', 17:52:28 INFO - 'LOGNAME': 'cltbld', 17:52:28 INFO - 'MAIL': '/var/mail/cltbld', 17:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:28 INFO - 'MOZ_NO_REMOTE': '1', 17:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:28 INFO - 'NO_EM_RESTART': '1', 17:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:28 INFO - 'PWD': '/builds/slave/test', 17:52:28 INFO - 'SHELL': '/bin/bash', 17:52:28 INFO - 'SHLVL': '1', 17:52:28 INFO - 'TERM': 'linux', 17:52:28 INFO - 'TMOUT': '86400', 17:52:28 INFO - 'USER': 'cltbld', 17:52:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:28 INFO - '_': '/tools/buildbot/bin/python'} 17:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:52:29 INFO - Cleaning up... 17:52:29 INFO - Return code: 0 17:52:29 INFO - Running post-action listener: _resource_record_post_action 17:52:29 INFO - Running post-action listener: _start_resource_monitoring 17:52:29 INFO - Starting resource monitoring. 17:52:29 INFO - [mozharness: 2017-07-17 00:52:29.199385Z] Finished create-virtualenv step (success) 17:52:29 INFO - [mozharness: 2017-07-17 00:52:29.200397Z] Running install step. 17:52:29 INFO - Running pre-action listener: _resource_record_pre_action 17:52:29 INFO - Running main action method: install 17:52:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:29 INFO - Reading from file tmpfile_stdout 17:52:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:52:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:52:29 INFO - Reading from file tmpfile_stdout 17:52:29 INFO - Output received: 17:52:29 INFO - Usage: mozinstall [options] installer 17:52:29 INFO - Options: 17:52:29 INFO - -h, --help show this help message and exit 17:52:29 INFO - -d DEST, --destination=DEST 17:52:29 INFO - Directory to install application into. [default: 17:52:29 INFO - "/builds/slave/test"] 17:52:29 INFO - --app=APP Application being installed. [default: firefox] 17:52:29 INFO - mkdir: /builds/slave/test/build/application 17:52:29 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'] 17:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:52:47 INFO - Reading from file tmpfile_stdout 17:52:47 INFO - Output received: 17:52:47 INFO - /builds/slave/test/build/application/firefox/firefox 17:52:47 INFO - Running post-action listener: _resource_record_post_action 17:52:47 INFO - [mozharness: 2017-07-17 00:52:47.458967Z] Finished install step (success) 17:52:47 INFO - [mozharness: 2017-07-17 00:52:47.459220Z] Running setup-mitmproxy step. 17:52:47 INFO - Running pre-action listener: _resource_record_pre_action 17:52:47 INFO - Running main action method: setup_mitmproxy 17:52:47 INFO - Skipping: mitmproxy is not required 17:52:47 INFO - Running post-action listener: _resource_record_post_action 17:52:47 INFO - [mozharness: 2017-07-17 00:52:47.460403Z] Finished setup-mitmproxy step (success) 17:52:47 INFO - [mozharness: 2017-07-17 00:52:47.460624Z] Running run-tests step. 17:52:47 INFO - Running pre-action listener: _resource_record_pre_action 17:52:47 INFO - Running pre-action listener: _set_gcov_prefix 17:52:47 INFO - Running main action method: run_tests 17:52:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:52:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:52:47 INFO - Python 2.7.3 17:52:47 INFO - Return code: 0 17:52:47 INFO - grabbing minidump binary from tooltool 17:52: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')]} 17:52:47 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 0x13a8d00>, '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 0x13a9c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aa090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:52:47 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 17:52:47 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 17:52:47 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 17:52:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:52:47 INFO - Return code: 0 17:52:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:52:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:52:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:52:47 INFO - ENV: RUST_BACKTRACE is now 1 17:52:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:52:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:52:47 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/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 17:52:47 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/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 17:52:47 INFO - Using env: {'DISPLAY': ':0', 17:52:47 INFO - 'HOME': '/home/cltbld', 17:52:47 INFO - 'LANG': 'en_US.UTF-8', 17:52:47 INFO - 'LANGUAGE': 'en_US:en', 17:52:47 INFO - 'LOGNAME': 'cltbld', 17:52:47 INFO - 'MAIL': '/var/mail/cltbld', 17:52:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:52:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:47 INFO - 'MOZ_NO_REMOTE': '1', 17:52:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:47 INFO - 'NO_EM_RESTART': '1', 17:52:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:47 INFO - 'PWD': '/builds/slave/test', 17:52:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:52:47 INFO - 'RUST_BACKTRACE': '1', 17:52:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:52:47 INFO - 'SHELL': '/bin/bash', 17:52:47 INFO - 'SHLVL': '1', 17:52:47 INFO - 'TERM': 'linux', 17:52:47 INFO - 'TMOUT': '86400', 17:52:47 INFO - 'USER': 'cltbld', 17:52:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536', 17:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:47 INFO - '_': '/tools/buildbot/bin/python'} 17:52:47 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/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 17:52:48 INFO - mozversion application_buildid: 20170717000747 17:52:48 INFO - mozversion application_changeset: aff336ac161daa3ea350e59a288963edbd58ed39 17:52:48 INFO - mozversion application_display_name: Nightly 17:52:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:52:48 INFO - mozversion application_name: Firefox 17:52:48 INFO - mozversion application_remotingname: firefox 17:52:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:52:48 INFO - mozversion application_vendor: Mozilla 17:52:48 INFO - mozversion application_version: 56.0a1 17:52:48 INFO - mozversion platform_buildid: 20170717000747 17:52:48 INFO - mozversion platform_changeset: aff336ac161daa3ea350e59a288963edbd58ed39 17:52:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:52:48 INFO - mozversion platform_version: 56.0a1 17:52:48 INFO - using testdate: 1500252768 17:52:48 INFO - actual date: 1500252768 17:52:48 INFO - starting webserver on 'localhost:51656' 17:52:48 INFO - SUITE-START | Running 2 tests 17:52:48 INFO - TEST-START | dromaeo_css 17:52:48 INFO - Initialising browser for dromaeo_css test... 17:52:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51656/getInfo.html -profile /tmp/tmpGYtEfe/profile 17:52:48 INFO - TEST-INFO | started process 3377 (/builds/slave/test/build/application/firefox/firefox http://localhost:51656/getInfo.html) 17:52:56 INFO - TEST-INFO | 3377: exit 0 17:52:56 INFO - Browser initialized. 17:52:56 INFO - Running cycle 1/1 for dromaeo_css test... 17:52:56 INFO - TEST-INFO | started process 3568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYtEfe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:53:07 INFO - PID 3568 | RSS: Main: 173416448 17:53:07 INFO - PID 3568 | 17:56:05 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51656/tests/dromaeo/cssquery-ext.html) 17:56:07 INFO - PID 3568 | RSS: Main: 178200576 17:56:07 INFO - PID 3568 | 17:59:09 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-ext.html (next: http://localhost:51656/tests/dromaeo/cssquery-jquery.html) 17:59:10 INFO - PID 3568 | RSS: Main: 176926720 17:59:10 INFO - PID 3568 | 18:02:11 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51656/tests/dromaeo/cssquery-mootools.html) 18:02:12 INFO - PID 3568 | RSS: Main: 179138560 18:02:12 INFO - PID 3568 | 18:05:14 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51656/tests/dromaeo/cssquery-prototype.html) 18:05:14 INFO - PID 3568 | RSS: Main: 177594368 18:05:14 INFO - PID 3568 | 18:08:18 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51656/tests/dromaeo/cssquery-yui.html) 18:08:18 INFO - PID 3568 | RSS: Main: 176619520 18:08:18 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | Cycle 1(1): loaded http://localhost:51656/tests/dromaeo/cssquery-yui.html (next: http://localhost:51656/tests/dromaeo/cssquery-dojo.html) 18:11:20 INFO - PID 3568 | RSS: Main: 180129792 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | __start_tp_report 18:11:20 INFO - PID 3568 | _x_x_mozilla_page_load 18:11:20 INFO - PID 3568 | _x_x_mozilla_page_load_details 18:11:20 INFO - PID 3568 | |i|pagename|runs| 18:11:20 INFO - PID 3568 | |0;dojo.html;3070.1557071805264;3107.1144723753728;3156.984215078924;3157.1317887580926;3165.430222559939;5879.176915231866;5886.617369870955;5891.263592050988;5932.1991531143285;5940.881182376355;5894.705264736756;5929.28848538176;5935.554833387491;5959.731812068457;5970.16417701521;5452.809151679692;5456.645318054314;5470.234167216593;5480.150576660624;5496.0931446311315;5457.590680698943;5467.699276539789;5467.890642187173;5480.04099282626;5510.752016159283;5509.724513774316;5514.228008078872;5523.6409633373705;5531.944680553183;5533.778648854041;5503.889922201573;5519.724013799334;5520.392756796769;5523.171524271352;5541.085720856054;5408.918866216971;5463.071277882769;5490.011797876381;5496.065668836308;5606.159076138571;5965.28416590012;6028.306744724369;6043.365446628085;6078.6048906820915;6105.755769769204;6378.425941665272;6418.871622567569;6488.6106833589665;6500.577462464925;6503.512236582275;6296.464800491918;6369.617822930639;6380.808575742735;6386.776462823779;6387.648679322635;5906.704664766745;5942.524598032147;5952.077427998667;5963.13534537494;5990.311114221877;6420;6479.6760161991715;6511.706973186218;6539.280679125292;6557;6303.432691057827;6317.526185536011;6324.3991820776955;6417.454516366068;6424.068510066014;6327.303996560375;6417.7753778617525;6436.806895793134;6494.025896115526;6507.479401647857;6220.471259942865;6221.377862213742;6298.937010629835;6307.400796924285;6399.9040014399825;6268.686565671698;6283.937160628427;6296.590721603081;6319.368063193736;6377.489800815923;5210.713410762369;5220.660657057279;5294.047071527085;5305.973470132624;5343.251944727741;4388.692791504628;4418.917365245536;4440.245158323029;4461;4512.34570987205;5478.068728316196;5504.311961004874;5512.200730893998;5545.1682247663175;5558.055130627803;6339.714712837934;6379.585326953733;6394.488440924715;6426.1003459515705;6433.163688720437;5491.176323551499;5527.944720552743;5534.225208470817;5540.778368865281;5644.8024319148635;5620.971895140498;5760;5801.8549536261935;5806.709664516842;5821.039528477839;6169.074638804125;6172.814815555541;6183.81448556544;6191.721372538246;6220.626762394271;6313.55805093639;6325.936740632719;6346.873062538816;6403.871922561616;6417.26201486835;6190.721417536131;6199.194104766532;6222.564420490703;6233.719482623203;6234.1583886174785;6296.527760418078;6298.11826344303;6343.794679010974;6371.96814015927;6385.45723613498;6479;6530.053142294436;6591.044298576776;6591.670416479061;6607.702653380513;6137.6931153441255;6227.816714824169;6280.968595157177;6284.842878928063;6376.330485298977;6185.103160041859;6194.969025154845;6197.81406557804;6207.81376558704;6207.875842483216;6083.452489275809;6142.600730952652;6143.600665956698;6155.815325540241;6168.1056246844855;5351.678899266057;6210.503159747119;6216.471599914058;6360.93639063622;6413.2945376007665;6071.5446341523675;6134.539909506894;6156.384361563808;6223.813285601439;6253.3121356651645 18:11:20 INFO - PID 3568 | |1;ext.html;865.961031753571;904.1184844776344;1171.6192237522807;1207.9698007549816;1216.1730023583964;30977.225569360777;36818.63181368189;38229.80885095578;41474.17051658965;41855.58144418555;42905;43335.78332108343;43397.56602433975;43407.56592434082;43453.34819977703;7588.089429268482;7666.118396384431;7673.117591476968;7720.845583088335;7734.1105772836;7608.6195690215545;7690.884636730453;7712.922870771276;7728.806779830493;7736.419768517356;7491.325780679737;7548.66031028605;7721.30508254257;7737.961310193441;7738;7613.619319034054;7665.118511371208;7681.193474685134;7701.152873183945;7707.614619269014;7454.329110380092;7593.392528597754;7629.961850190713;7644.044494438195;7650.311471967494;38752;38817.41773873366;38823.22353552941;39114;39135.804320978496;3493.545839040934;3530.505729197914;3536.4341705327283;3541.8937431876825;3546.4325707886615;31303.843480782678;31407.685923140703;31430.371392572248;31609.841950790098;31673.366532669217;4807.19730101212;4846.273059041137;4882.389701287339;4884.3650325457465;4976.726280054596;213198;215902;219471;221359;222366;50142.24786628131;50191;50472.242916356285;50490.495095049315;50597.747011264706;44645.77677111659;46095.76952115218;46105.538944610125;52717.73641131847;53047.46952530425;14394;16292.755608665879;16515.17424128813;16573.83426165723;16657.33370665184;13732.45070197201;13782;13857.307134643228;13869.861301387058;13889;14338.139711617336;14491.347889345005;14508.927455362656;14537.92731036338;14543.127412355292;5619.971900140473;5627.380988091307;5805.390434004453;5876.853078673067;5887.76448942046;990.663174520652;1002.4185972136144;1013.3463915774431;1042.2652030318607;1052.3002203534563;22907.541849162924;23057.30828075127;23921.28236152918;29058.41883162325;29458.116256512338;1109.1681239070697;1113.0205419231024;1115.866096068477;1116.2799994003822;1124.4321617583232;12605.432755526022;12619.621411357673;12694.238345699288;12757.617271481871;12765.872341276468;224618;225877;227085;227485;227727;51926.74036629868;52339.476605234224;52524.73737631287;52649.2102618461;52743.20885186725;1407.1627381707867;1480.8445113263167;1484.9777253341208;1502.2638906935522;1507.0580886945659;22137.889310553343;22387;22566.774332257122;23150.421239468473;23363.76636233616;37947.81026094852;38146.2370752589;38327.42508862425;38400.231995359376;38454.80772596119;196512;196932;197769;197964;198021;34360.312793743484;36180.27639447249;36903;38669.22661546697;38770.4184437228;46436.606901793;47762.28356574724;48016.519834801205;48303.27545086897;49050;34325.82837085899;34651.13372165716;35228.295434091684;35312.29375412529;35759.82120089383;33560.66439335576;36581.63418365782;36596.45105323369;36820.263594728494;36937.81531092327;40680.38979415252;40923.38614920838;41456;41778.79110604428;41874.37188442115;40912.79543602263;42248;42742;42826.57173428226;43067;29693.703062969093;30378.84810575933;30737;30966.380672386877;31692.683073168973 18:11:20 INFO - PID 3568 | |2;jquery.html;564.2129229724537;571.2060236271581;579.9971000144999;587.1632923084604;594.2927915780222;21611.45971350715;22404;22515.211967581137;22556.774432255672;22561.77438225617;24379;25806.225813225585;26920.192394228154;27008.459830803422;27267.86366068167;6598.604083754978;6751.459883209356;6769.492288078389;6783;6806.965965170167;6690.933090669104;6727.6636168191635;6746.19045714515;6749.35881091298;6761.053452516651;5865.618734782247;6234.407731265523;6391.648459334735;6421.133147025139;6724.462043036546;6320.178376811031;6334.904976425334;6377.872442551123;6381.3937675920715;6383.010633351838;5913.733881975321;5962;5965.433283838029;5974.253218347707;5980.342162362137;27071.86464067667;29113.854430727923;29212.123636290944;29288.853555732298;29617.259568510744;1886.3209244671907;1908.2557802457052;1913.5024893527643;1937;1937.7577802774654;18868.15093320804;19260.807391926042;19352;19393.4181974541;19408.514787130294;2270.3189043286948;2322.372959300996;2365.9053637854636;2376.988115059431;2393.664886915833;125332;129321.35339323337;130829.34585327108;131241;131318;14094.577162685136;14990.325435355435;15349.002314849498;15432.839402483662;15620.84379156194;23373.649395259086;23417.41456463602;23435.296941091452;23485.41286467852;23501.17745878886;10111;10126.59493620247;10210.38737675727;10291.485425728684;10344.5344959477;9408.905910940939;9451.716448506555;9559.330846840794;9579.952100239454;9583.712488625353;9195.310351723647;9251.67619133327;9256.305777066747;9558.90441095594;9628.855567166358;2610.2983412168314;2726.209399274228;2740.7259274072435;2814.9859250703616;2820.252633052243;938.7090002099235;951.46242373059;953.8426159683713;986.9654562090436;989.3618615992789;19658.46564416257;19799.01004949747;19903.303384381477;20518.076686549142;20631.484212894797;1001.4942454060653;1028.9382637041651;1050.2910535388583;1053.757635743783;1054.1672079057612;10808.405537695502;10987.175961802737;11083.944580277048;11095;11349.69631085005;437344;475433;478381;484957;490084;108879.45560272149;112551;112668.43665781783;115228;115344;1201.0632683775445;1210.933398663082;1241.2366394667215;1242.521629172757;1244.7572723319047;16724.163791810603;17848.643027139125;17922.91038544851;18031.63936721232;18043.278268869097;56712.43287567236;57747.42252577421;58556;60990;62150;68945.31054689389;69657;70034.29965700278;70587.64706176436;70743.64628176826;14867.479638212611;15429.768553471931;15440.84559154394;15452.5364239073;15468.613284667523;20581.794182057987;23747.881260593585;24069.398265043514;24228.757712422652;24652;18514.351997680016;18793.90603046976;18941.14764835613;18961.14674839608;19075.236990520778;15824;16419.671606567565;17236.138193090046;17294.135293235035;17571.56071098233;17876.731849022013;19048.42854714361;19293.903530482257;19343.4196974091;19429;14814.703705925605;15167.544973650809;15189.316480758613;15265.465708700141;15294.388224470897;17248.827511725223;18551.72172417388;18741.34405295808;18791.34230301933;19004.14481348315 18:11:20 INFO - PID 3568 | |3;mootools.html;1336.6925607110365;1383.1908333624829;1388.7153133607612;1401.9509317173902;1413.1309244814436;12674.112812103145;13190.406431710571;13283.33583320835;13359.866401335983;13370.598882033542;13266.535671251508;13524.729505409887;13543.661408464794;13548.390322435489;13567;2585.818992670509;2628.8554129522868;2632.197179860142;2644.2596073099467;2656.933576660589;2548.4903019396197;2631.302704783234;2637.815352925296;2640.7227241139594;2647.0735242665105;2555;2567.974320256792;2598.8440693558355;2604.2708041748247;2629.1455277034943;2482.7641374069526;2535.657686212356;2550.8341957772686;2554.706208785995;2556.7826734727664;2465.7287698353166;2480.9255722328357;2490.489449662815;2494.301595553248;2503.5618766715934;12581.182223155465;12818.423170957236;12827.166234194841;12827.422765975554;12830.935845320808;6789.117414736102;7075.39859111971;7080.256573059857;7093.432525397956;7117.572945623279;4640.582347588733;4722.173619616553;4760.452547956995;4857.927131093036;4874.049560335736;1856.7400563921062;1858.2938483376365;1886.8867867927968;1925.1433112265047;1931.58470928751;19047.333343332917;19736.802631973496;20434;20569.794302056936;20608.896955515127;5377.946220537823;5475.67145971243;5806.129080637938;6023.6385816851125;6032.276126864805;14771.482998095014;14794.334254958552;14824.407023719146;14826;14867.330970106155;6941.409980151744;6966.860662786716;6970.407515361251;6982.092327997328;6983.650817459208;6358.173437453194;6543.509236807164;6558.770443034471;6562.409383155539;6587.4071333580205;4507.166174257773;4620.1221767864;4676.298555216745;4705.153072446924;4726.527347265246;1326.7611829870716;1334.1461464662623;1352.8985326100583;1365.7678194706923;1369.2537567025995;868.6612221233723;880.9911900881037;886.1935638568872;899.9685011024714;920.7882187097006;7076.823079423056;7156.60638664868;7226.205117437078;7264.963675181696;7341.641796267708;703.5426972467936;706.9010338552607;718.6801873166495;720.5280541245493;720.8342081321325;4264.744115353089;5166.844994650167;5305.814296499681;5332.466753324637;5390.380106287748;17843.73234401485;17964.371247006293;18091.909540452212;18184.9090754548;18229.088545572667;17047.232874520676;17463.825361746472;17479.126043697765;17568.472945811645;17948;10159.238057145743;10319.535620897077;10344.482775861177;10407.635732749317;10410.271281010257;7482.999970131693;7898.565578893216;7970.123286438603;8068.394870384627;8197.549134797644;14458.843292536361;14879.776803348175;15747.291371888063;15769.921150394175;15890.920545397199;14809.777853332424;15147.697046058796;15438;15545.611359716098;16012.439564615182;10322.12261957742;10642.148628109579;10670.89329106699;10706.197035222234;10712.303700259457;12155.088368372584;12321.568745093879;12338.50645974187;12371.195872268274;12374.690632733893;9748.22014238845;10010.849837252592;10150.54322555472;10324.845127323246;10329.173666106542;9528.761780955532;9884.604615815288;9933.106020458194;9935.850962235716;10060.195184385379;8899.822003560022;9174.816503670023;9188.95405522968;9202.401843880127;9267.907320926704;6852;7019.859602808017;7024.262452442625;7064.894026589503;7107.2120087031;6568.540202185993;6733.6296503692765;6776.7628133015105;6785.287544807724;6918.515703900679 18:11:20 INFO - PID 3568 | |4;prototype.html;482.966192366534;504.2083928232674;521.9269302297678;522.156716902203;527.4303751947897;6012.789552365668;6044.455998960093;6073.817785466437;6081.665508397036;6123.663198524079;5779.248697669308;5953.315368732597;5978.760849566023;5981.222441082664;6023.819285421433;4842;4899.730514821684;4903.362562866841;4921.4340350859575;4945.134601444751;4838.298446725223;4865.34317867087;4874.65877388583;4886.193778026622;4917.893473968365;4837.5646191842725;4879.39007624047;4898.142825005628;4908.386451693538;4920.655554111214;4684.391029166203;4804.279358096279;4808.68743531671;4879.341288926021;4907.975460122677;4385.627221686161;4388.981068708398;4410.536893626155;4422.336649502568;4423.292273236267;5777.364489906107;5859.501942334907;5866.882662346729;5894.322152952423;5903.675297858616;5546.168074788774;5576.1356989666665;5602.943970560283;5656.575756818214;5687.857803554903;6303.338149494329;6303.842403939892;6305.527085468562;6344.809655710336;6389.936100638981;4818.951810481885;4832.685875418087;4838.395200599925;4858.732769697665;4892.6575139740235;6682.83292917676;6721.361470660279;6725.596464212114;6766.357196066366;6894.413974812147;4955.835378686006;4966.279889416014;4982.053409852117;4982.153033984159;4984.327115839388;5026.346574945233;5027.3464449621315;5029.1450453423;5075.847724568269;5088.262201980692;5515.503604675599;5567.638103523258;5568.415316391802;5575.4424557543925;5636.464535869086;6359.395857393541;6393.936060639334;6409.391107844747;6410.1987251593555;6518.641474718936;1718.4276387105908;1765.7439671247598;1766.5495298699007;1768.32803534656;1770.7255375416573;1122.1583812140893;1218.4151607228403;1232.6133100262205;1232.7103130764262;1235.8269842222096;5443.83668489938;5524.309461317335;5584.035334912258;5654.858628534237;5668.744906479218;6482.902756458562;6508.674566271668;6585.6707164641575;6624.012796161132;6657.13457250564;5611.242482264842;5655.123455864347;5675.886482270332;5684.289463817023;5693.629914055573;3490.650934906489;3519.102628829632;3526.947095793565;3527.8236088195486;3564.8752293669595;6419.679016049179;6441.742330306829;6472.3204063573585;6481.09264702942;6514.413702766774;6740.39336459721;6799.626020568916;6816.318368163244;6842.278827608934;6843.213030501456;6418.293987661354;6425.004124360731;6449.3873082057125;6477.481801455872;6524.249711283073;6511.413972742476;6547.247066587403;6586.176727909012;6665.666716664245;6671.46628269747;6511.283758786435;6517.543771935919;6539.771108011197;6551.541392102507;6566.9014964776525;6272;6274.403931626488;6343.270523889812;6391.776287829904;6427.967860160669;4871.196252618278;4912.852614421573;4924.138275801792;4939.678920870132;4949.82675606352;6589.4069533742195;6616.206055273398;6640.273528882429;6649.301823308483;6664.866702666017;6406.519511036598;6413.839654008687;6443.194600674916;6445.387688169616;6483.578567393104;6404.847127516905;6425.06836508713;6474.125992991075;6505.121808555785;6511.34886511345;6365.61806291624;6371.74513019474;6374.840628984312;6383.585066970632;6418.19772528434;5921.911171332347;6374.322784430643;6399.488040956805;6418.614883107029;6450.967745161244;6148.723307451265;6157.6613286269685;6183.443490085914;6211.3167551570195;6226.346233645583 18:11:20 INFO - PID 3568 | |5;yui.html;908.5820522559623;917.6512925088465;929.7210836748978;929.9953500232498;934.1219253901337;16624;16908.239129239184;17498.475045748648;17514.737278940825;17570.29718811249;19759.70360444591;20642.48393790156;21649.783502164973;21760;21770.455738606543;1020.6070662794822;1060.0724366179593;1066.695991642382;1068.9358638481715;1070.7430216747964;1059.8357254625546;1073.2862646340175;1073.7100982734657;1073.726199819045;1075.1237741240864;1003.4481035430521;1043.9164866810636;1102.101787043557;1104.0560320925613;1105.7567335186245;1073.924825262232;1079.7462596289865;1083.5611577311201;1084.8372744088372;1086.7337502311905;752.1838804896639;789.1319548496665;795.562440657636;801.4309840013598;803.7146812881401;19352.70970935437;19484.90257548703;19510.80489195104;19585.1186696599;19681.606367872704;16945.40691075819;19587.80412195874;20563.691544626843;20694.379168624964;20783.792162078338;15857.048577085412;16564.83435165657;16586.917065414596;16723.91638041814;16748.162591870358;3525.8589656413715;3566.4293713005795;3577.6601222883783;3582.6417358264225;3592.5329707138167;111776;113972.4301378496;115075.42462287718;115473.99999999916;117296.41351793271;15824.841751582337;16159.272832722556;16248.75626865598;16478.588035299214;16740.242274560995;30120.84939575288;30416;30948.22629434282;30996.53505197424;31900.202494937814;8562.186592273723;8760.605772740242;8763.912360876437;8785.69250076257;8803.955980220058;3923.0976875318265;4164.8125834337525;4236.491621005499;4244.0026593750445;4272.33778764292;5032.974835125801;5098;5110.156824124052;5155.690658560424;5160.638755287094;817.750586071254;845.6067928413318;845.8266055458616;985.5959056786826;996.7059717383389;705.2172088981226;712.0814149746768;715.2811424518326;722.7795522365728;733.8899165125274;11058.612948546923;11386.487608057658;11557.711057223636;11727.35499547516;11954.402279885971;679.6465837764433;701.2391555162706;702.8242939265184;716.9390601798801;731.3856360657073;5111.488851114858;5184.585233181337;5236.450172731808;5504.366997795225;5708.315002199763;97405;99882;101792;103092;105202;85791;89805.55097224603;91412;92688.53655731813;94808.52595736977;73509.63245183846;75534.62232688801;78454;80140;81414.59292703499;10799.352038877692;10895.346279222955;10999.670009899715;11255.437228138724;11365.374904380338;35625.28749424945;35892.461613076346;36477.63522364743;36621.26757464889;36957.26085478222;44011.55988440075;45148.32277515905;45910.62268131961;46389.53610463852;46896;16449.25978331002;16686.49940501787;16706.331746729993;16748.078855663054;16976.40582579604;18020.459386218434;18496;18528.629427411644;18535.258589656263;18629.627407452048;16310.184490775651;16788.916055419646;17246.396376126777;18038.36865709694;18115.72826407631;17598.73601895947;17613.911930440267;17704.29182832672;17807.554811129827;17902;16901.112953823365;17900.641987160445;18350.632987340447;18382.448526544224;18508.537286567942;12823.294718790556;12823.294718790556;12950.870491295344;12977.740445190855;13058.21650700961;12735.55425560101;13012.804807928078;13155.210687358789;13303.26832024248;13454.663633409244 18:11:20 INFO - PID 3568 | __end_tp_report 18:11:20 INFO - PID 3568 | __start_cc_report 18:11:20 INFO - PID 3568 | _x_x_mozilla_cycle_collect,354 18:11:20 INFO - PID 3568 | __end_cc_report 18:11:20 INFO - PID 3568 | __startTimestamp1500253880683__endTimestamp 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | ------- Summary: start ------- 18:11:20 INFO - PID 3568 | Number of tests: 6 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | [#0] dojo.html Cycles:165 Average:5898.71 Median:6155.82 stddev:673.55 (10.9%) stddev-sans-first:638.02 18:11:20 INFO - PID 3568 | Values: 3070.2 3107.1 3157.0 3157.1 3165.4 5879.2 5886.6 5891.3 5932.2 5940.9 5894.7 5929.3 5935.6 5959.7 5970.2 5452.8 5456.6 5470.2 5480.2 5496.1 5457.6 5467.7 5467.9 5480.0 5510.8 5509.7 5514.2 5523.6 5531.9 5533.8 5503.9 5519.7 5520.4 5523.2 5541.1 5408.9 5463.1 5490.0 5496.1 5606.2 5965.3 6028.3 6043.4 6078.6 6105.8 6378.4 6418.9 6488.6 6500.6 6503.5 6296.5 6369.6 6380.8 6386.8 6387.6 5906.7 5942.5 5952.1 5963.1 5990.3 6420.0 6479.7 6511.7 6539.3 6557.0 6303.4 6317.5 6324.4 6417.5 6424.1 6327.3 6417.8 6436.8 6494.0 6507.5 6220.5 6221.4 6298.9 6307.4 6399.9 6268.7 6283.9 6296.6 6319.4 6377.5 5210.7 5220.7 5294.0 5306.0 5343.3 4388.7 4418.9 4440.2 4461.0 4512.3 5478.1 5504.3 5512.2 5545.2 5558.1 6339.7 6379.6 6394.5 6426.1 6433.2 5491.2 5527.9 5534.2 5540.8 5644.8 5621.0 5760.0 5801.9 5806.7 5821.0 6169.1 6172.8 6183.8 6191.7 6220.6 6313.6 6325.9 6346.9 6403.9 6417.3 6190.7 6199.2 6222.6 6233.7 6234.2 6296.5 6298.1 6343.8 6372.0 6385.5 6479.0 6530.1 6591.0 6591.7 6607.7 6137.7 6227.8 6281.0 6284.8 6376.3 6185.1 6195.0 6197.8 6207.8 6207.9 6083.5 6142.6 6143.6 6155.8 6168.1 5351.7 6210.5 6216.5 6360.9 6413.3 6071.5 6134.5 6156.4 6223.8 6253.3 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | [#1] ext.html Cycles:180 Average:39353.01 Median:36920.41 stddev:55499.02 (150.3%) stddev-sans-first:55579.47 18:11:20 INFO - PID 3568 | Values: 866.0 904.1 1171.6 1208.0 1216.2 30977.2 36818.6 38229.8 41474.2 41855.6 42905.0 43335.8 43397.6 43407.6 43453.3 7588.1 7666.1 7673.1 7720.8 7734.1 7608.6 7690.9 7712.9 7728.8 7736.4 7491.3 7548.7 7721.3 7738.0 7738.0 7613.6 7665.1 7681.2 7701.2 7707.6 7454.3 7593.4 7630.0 7644.0 7650.3 38752.0 38817.4 38823.2 39114.0 39135.8 3493.5 3530.5 3536.4 3541.9 3546.4 31303.8 31407.7 31430.4 31609.8 31673.4 4807.2 4846.3 4882.4 4884.4 4976.7 213198.0 215902.0 219471.0 221359.0 222366.0 50142.2 50191.0 50472.2 50490.5 50597.7 44645.8 46095.8 46105.5 52717.7 53047.5 14394.0 16292.8 16515.2 16573.8 16657.3 13732.5 13782.0 13857.3 13869.9 13889.0 14338.1 14491.3 14508.9 14537.9 14543.1 5620.0 5627.4 5805.4 5876.9 5887.8 990.7 1002.4 1013.3 1042.3 1052.3 22907.5 23057.3 23921.3 29058.4 29458.1 1109.2 1113.0 1115.9 1116.3 1124.4 12605.4 12619.6 12694.2 12757.6 12765.9 224618.0 225877.0 227085.0 227485.0 227727.0 51926.7 52339.5 52524.7 52649.2 52743.2 1407.2 1480.8 1485.0 1502.3 1507.1 22137.9 22387.0 22566.8 23150.4 23363.8 37947.8 38146.2 38327.4 38400.2 38454.8 196512.0 196932.0 197769.0 197964.0 198021.0 34360.3 36180.3 36903.0 38669.2 38770.4 46436.6 47762.3 48016.5 48303.3 49050.0 34325.8 34651.1 35228.3 35312.3 35759.8 33560.7 36581.6 36596.5 36820.3 36937.8 40680.4 40923.4 41456.0 41778.8 41874.4 40912.8 42248.0 42742.0 42826.6 43067.0 29693.7 30378.8 30737.0 30966.4 31692.7 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | [#2] jquery.html Cycles:180 Average:34120.19 Median:12416.05 stddev:79673.30 (641.7%) stddev-sans-first:79856.97 18:11:20 INFO - PID 3568 | Values: 564.2 571.2 580.0 587.2 594.3 21611.5 22404.0 22515.2 22556.8 22561.8 24379.0 25806.2 26920.2 27008.5 27267.9 6598.6 6751.5 6769.5 6783.0 6807.0 6690.9 6727.7 6746.2 6749.4 6761.1 5865.6 6234.4 6391.6 6421.1 6724.5 6320.2 6334.9 6377.9 6381.4 6383.0 5913.7 5962.0 5965.4 5974.3 5980.3 27071.9 29113.9 29212.1 29288.9 29617.3 1886.3 1908.3 1913.5 1937.0 1937.8 18868.2 19260.8 19352.0 19393.4 19408.5 2270.3 2322.4 2365.9 2377.0 2393.7 125332.0 129321.4 130829.3 131241.0 131318.0 14094.6 14990.3 15349.0 15432.8 15620.8 23373.6 23417.4 23435.3 23485.4 23501.2 10111.0 10126.6 10210.4 10291.5 10344.5 9408.9 9451.7 9559.3 9580.0 9583.7 9195.3 9251.7 9256.3 9558.9 9628.9 2610.3 2726.2 2740.7 2815.0 2820.3 938.7 951.5 953.8 987.0 989.4 19658.5 19799.0 19903.3 20518.1 20631.5 1001.5 1028.9 1050.3 1053.8 1054.2 10808.4 10987.2 11083.9 11095.0 11349.7 437344.0 475433.0 478381.0 484957.0 490084.0 108879.5 112551.0 112668.4 115228.0 115344.0 1201.1 1210.9 1241.2 1242.5 1244.8 16724.2 17848.6 17922.9 18031.6 18043.3 56712.4 57747.4 58556.0 60990.0 62150.0 68945.3 69657.0 70034.3 70587.6 70743.6 14867.5 15429.8 15440.8 15452.5 15468.6 20581.8 23747.9 24069.4 24228.8 24652.0 18514.4 18793.9 18941.1 18961.1 19075.2 15824.0 16419.7 17236.1 17294.1 17571.6 17876.7 19048.4 19293.9 19343.4 19429.0 14814.7 15167.5 15189.3 15265.5 15294.4 17248.8 18551.7 18741.3 18791.3 19004.1 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | [#3] mootools.html Cycles:180 Average:8105.59 Median:2555.89 stddev:5369.84 (210.1%) stddev-sans-first:5360.82 18:11:20 INFO - PID 3568 | Values: 1336.7 1383.2 1388.7 1402.0 1413.1 12674.1 13190.4 13283.3 13359.9 13370.6 13266.5 13524.7 13543.7 13548.4 13567.0 2585.8 2628.9 2632.2 2644.3 2656.9 2548.5 2631.3 2637.8 2640.7 2647.1 2555.0 2568.0 2598.8 2604.3 2629.1 2482.8 2535.7 2550.8 2554.7 2556.8 2465.7 2480.9 2490.5 2494.3 2503.6 12581.2 12818.4 12827.2 12827.4 12830.9 6789.1 7075.4 7080.3 7093.4 7117.6 4640.6 4722.2 4760.5 4857.9 4874.0 1856.7 1858.3 1886.9 1925.1 1931.6 19047.3 19736.8 20434.0 20569.8 20608.9 5377.9 5475.7 5806.1 6023.6 6032.3 14771.5 14794.3 14824.4 14826.0 14867.3 6941.4 6966.9 6970.4 6982.1 6983.7 6358.2 6543.5 6558.8 6562.4 6587.4 4507.2 4620.1 4676.3 4705.2 4726.5 1326.8 1334.1 1352.9 1365.8 1369.3 868.7 881.0 886.2 900.0 920.8 7076.8 7156.6 7226.2 7265.0 7341.6 703.5 706.9 718.7 720.5 720.8 4264.7 5166.8 5305.8 5332.5 5390.4 17843.7 17964.4 18091.9 18184.9 18229.1 17047.2 17463.8 17479.1 17568.5 17948.0 10159.2 10319.5 10344.5 10407.6 10410.3 7483.0 7898.6 7970.1 8068.4 8197.5 14458.8 14879.8 15747.3 15769.9 15890.9 14809.8 15147.7 15438.0 15545.6 16012.4 10322.1 10642.1 10670.9 10706.2 10712.3 12155.1 12321.6 12338.5 12371.2 12374.7 9748.2 10010.8 10150.5 10324.8 10329.2 9528.8 9884.6 9933.1 9935.9 10060.2 8899.8 9174.8 9189.0 9202.4 9267.9 6852.0 7019.9 7024.3 7064.9 7107.2 6568.5 6733.6 6776.8 6785.3 6918.5 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | [#4] prototype.html Cycles:180 Average:5407.92 Median:5912.79 stddev:1509.20 (25.5%) stddev-sans-first:1467.46 18:11:20 INFO - PID 3568 | Values: 483.0 504.2 521.9 522.2 527.4 6012.8 6044.5 6073.8 6081.7 6123.7 5779.2 5953.3 5978.8 5981.2 6023.8 4842.0 4899.7 4903.4 4921.4 4945.1 4838.3 4865.3 4874.7 4886.2 4917.9 4837.6 4879.4 4898.1 4908.4 4920.7 4684.4 4804.3 4808.7 4879.3 4908.0 4385.6 4389.0 4410.5 4422.3 4423.3 5777.4 5859.5 5866.9 5894.3 5903.7 5546.2 5576.1 5602.9 5656.6 5687.9 6303.3 6303.8 6305.5 6344.8 6389.9 4819.0 4832.7 4838.4 4858.7 4892.7 6682.8 6721.4 6725.6 6766.4 6894.4 4955.8 4966.3 4982.1 4982.2 4984.3 5026.3 5027.3 5029.1 5075.8 5088.3 5515.5 5567.6 5568.4 5575.4 5636.5 6359.4 6393.9 6409.4 6410.2 6518.6 1718.4 1765.7 1766.5 1768.3 1770.7 1122.2 1218.4 1232.6 1232.7 1235.8 5443.8 5524.3 5584.0 5654.9 5668.7 6482.9 6508.7 6585.7 6624.0 6657.1 5611.2 5655.1 5675.9 5684.3 5693.6 3490.7 3519.1 3526.9 3527.8 3564.9 6419.7 6441.7 6472.3 6481.1 6514.4 6740.4 6799.6 6816.3 6842.3 6843.2 6418.3 6425.0 6449.4 6477.5 6524.2 6511.4 6547.2 6586.2 6665.7 6671.5 6511.3 6517.5 6539.8 6551.5 6566.9 6272.0 6274.4 6343.3 6391.8 6428.0 4871.2 4912.9 4924.1 4939.7 4949.8 6589.4 6616.2 6640.3 6649.3 6664.9 6406.5 6413.8 6443.2 6445.4 6483.6 6404.8 6425.1 6474.1 6505.1 6511.3 6365.6 6371.7 6374.8 6383.6 6418.2 5921.9 6374.3 6399.5 6418.6 6451.0 6148.7 6157.7 6183.4 6211.3 6226.3 18:11:20 INFO - PID 3568 | 18:11:20 INFO - PID 3568 | [#5] yui.html Cycles:180 Average:21673.05 Median:19497.85 stddev:28768.15 (147.5%) stddev-sans-first:28806.60 18:11:20 INFO - PID 3568 | Values: 908.6 917.7 929.7 930.0 934.1 16624.0 16908.2 17498.5 17514.7 17570.3 19759.7 20642.5 21649.8 21760.0 21770.5 1020.6 1060.1 1066.7 1068.9 1070.7 1059.8 1073.3 1073.7 1073.7 1075.1 1003.4 1043.9 1102.1 1104.1 1105.8 1073.9 1079.7 1083.6 1084.8 1086.7 752.2 789.1 795.6 801.4 803.7 19352.7 19484.9 19510.8 19585.1 19681.6 16945.4 19587.8 20563.7 20694.4 20783.8 15857.0 16564.8 16586.9 16723.9 16748.2 3525.9 3566.4 3577.7 3582.6 3592.5 111776.0 113972.4 115075.4 115474.0 117296.4 15824.8 16159.3 16248.8 16478.6 16740.2 30120.8 30416.0 30948.2 30996.5 31900.2 8562.2 8760.6 8763.9 8785.7 8804.0 3923.1 4164.8 4236.5 4244.0 4272.3 5033.0 5098.0 5110.2 5155.7 5160.6 817.8 845.6 845.8 985.6 996.7 705.2 712.1 715.3 722.8 733.9 11058.6 11386.5 11557.7 11727.4 11954.4 679.6 701.2 702.8 716.9 731.4 5111.5 5184.6 5236.5 5504.4 5708.3 97405.0 99882.0 101792.0 103092.0 105202.0 85791.0 89805.6 91412.0 92688.5 94808.5 73509.6 75534.6 78454.0 80140.0 81414.6 10799.4 10895.3 10999.7 11255.4 11365.4 35625.3 35892.5 36477.6 36621.3 36957.3 44011.6 45148.3 45910.6 46389.5 46896.0 16449.3 16686.5 16706.3 16748.1 16976.4 18020.5 18496.0 18528.6 18535.3 18629.6 16310.2 16788.9 17246.4 18038.4 18115.7 17598.7 17613.9 17704.3 17807.6 17902.0 16901.1 17900.6 18350.6 18382.4 18508.5 12823.3 12823.3 12950.9 12977.7 13058.2 12735.6 13012.8 13155.2 13303.3 13454.7 18:11:20 INFO - PID 3568 | -------- Summary: end -------- 18:11:20 INFO - PID 3568 | 18:11:21 INFO - TEST-INFO | 3568: exit 0 18:11:21 INFO - TEST-OK | dromaeo_css | took 1113022ms 18:11:21 INFO - TEST-START | kraken 18:11:21 INFO - Initialising browser for kraken test... 18:11:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51656/getInfo.html -profile /tmp/tmpQkbCW9/profile 18:11:21 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox http://localhost:51656/getInfo.html) 18:11:27 INFO - TEST-INFO | 3973: exit 0 18:11:27 INFO - Browser initialized. 18:11:27 INFO - Running cycle 1/1 for kraken test... 18:11:27 INFO - TEST-INFO | started process 4203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQkbCW9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:38 INFO - PID 4203 | RSS: Main: 169467904 18:11:38 INFO - PID 4203 | 18:11:41 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-beat-detection) 18:11:42 INFO - PID 4203 | RSS: Main: 175697920 18:11:42 INFO - PID 4203 | 18:11:45 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-dft) 18:11:45 INFO - PID 4203 | RSS: Main: 176185344 18:11:45 INFO - PID 4203 | 18:11:48 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-fft) 18:11:49 INFO - PID 4203 | RSS: Main: 170184704 18:11:49 INFO - PID 4203 | 18:11:51 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51656/tests/kraken/driver.html?testName=audio-oscillator) 18:11:51 INFO - PID 4203 | RSS: Main: 171560960 18:11:51 INFO - PID 4203 | 18:11:54 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51656/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:11:54 INFO - PID 4203 | RSS: Main: 171745280 18:11:54 INFO - PID 4203 | 18:11:57 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51656/tests/kraken/driver.html?testName=imaging-darkroom) 18:11:58 INFO - PID 4203 | RSS: Main: 174739456 18:11:58 INFO - PID 4203 | 18:12:01 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51656/tests/kraken/driver.html?testName=imaging-desaturate) 18:12:02 INFO - PID 4203 | RSS: Main: 176041984 18:12:02 INFO - PID 4203 | 18:12:05 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51656/tests/kraken/driver.html?testName=json-parse-financial) 18:12:05 INFO - PID 4203 | RSS: Main: 175087616 18:12:05 INFO - PID 4203 | 18:12:07 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51656/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:12:07 INFO - PID 4203 | RSS: Main: 174960640 18:12:07 INFO - PID 4203 | 18:12:09 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:12:10 INFO - PID 4203 | RSS: Main: 174940160 18:12:10 INFO - PID 4203 | 18:12:12 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:12:13 INFO - PID 4203 | RSS: Main: 175382528 18:12:13 INFO - PID 4203 | 18:12:15 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:12:16 INFO - PID 4203 | RSS: Main: 174784512 18:12:16 INFO - PID 4203 | 18:12:19 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:12:20 INFO - PID 4203 | RSS: Main: 175345664 18:12:20 INFO - PID 4203 | 18:12:21 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:51656/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51656/tests/kraken/driver.html?testName=ai-astar) 18:12:22 INFO - PID 4203 | RSS: Main: 176873472 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | __start_tp_report 18:12:22 INFO - PID 4203 | _x_x_mozilla_page_load 18:12:22 INFO - PID 4203 | _x_x_mozilla_page_load_details 18:12:22 INFO - PID 4203 | |i|pagename|runs| 18:12:22 INFO - PID 4203 | |0;ai-astar;102;111;109;109;108;109;108;108;109;110 18:12:22 INFO - PID 4203 | |1;audio-beat-detection;146;120;144;173;122;153;152;125;169;122 18:12:22 INFO - PID 4203 | |2;audio-dft;165;163;163;162;163;174;164;161;165;173 18:12:22 INFO - PID 4203 | |3;audio-fft;77;75;75;172;78;74;73;73;100;77 18:12:22 INFO - PID 4203 | |4;audio-oscillator;82;81;142;82;83;81;133;81;82;129 18:12:22 INFO - PID 4203 | |5;imaging-gaussian-blur;113;113;113;113;114;114;114;114;113;114 18:12:22 INFO - PID 4203 | |6;imaging-darkroom;149;150;153;150;150;150;150;151;149;149 18:12:22 INFO - PID 4203 | |7;imaging-desaturate;95;95;96;94;95;95;95;94;94;95 18:12:22 INFO - PID 4203 | |8;json-parse-financial;60;56;56;55;57;59;55;55;56;61 18:12:22 INFO - PID 4203 | |9;json-stringify-tinderbox;53;54;55;54;54;54;54;54;55;55 18:12:22 INFO - PID 4203 | |10;stanford-crypto-aes;76;77;76;77;77;100;75;85;76;76 18:12:22 INFO - PID 4203 | |11;stanford-crypto-ccm;138;133;126;135;130;127;128;129;128;157 18:12:22 INFO - PID 4203 | |12;stanford-crypto-pbkdf2;185;184;185;182;181;188;195;178;181;177 18:12:22 INFO - PID 4203 | |13;stanford-crypto-sha256-iterative;67;68;68;75;73;79;68;68;72;67 18:12:22 INFO - PID 4203 | __end_tp_report 18:12:22 INFO - PID 4203 | __start_cc_report 18:12:22 INFO - PID 4203 | _x_x_mozilla_cycle_collect,985 18:12:22 INFO - PID 4203 | __end_cc_report 18:12:22 INFO - PID 4203 | __startTimestamp1500253942063__endTimestamp 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | ------- Summary: start ------- 18:12:22 INFO - PID 4203 | Number of tests: 14 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:2.41 (2.2%) stddev-sans-first:1.00 18:12:22 INFO - PID 4203 | Values: 102.0 111.0 109.0 109.0 108.0 109.0 108.0 108.0 109.0 110.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:149.00 stddev:19.72 (13.2%) stddev-sans-first:20.88 18:12:22 INFO - PID 4203 | Values: 146.0 120.0 144.0 173.0 122.0 153.0 152.0 125.0 169.0 122.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.50 (2.7%) stddev-sans-first:4.77 18:12:22 INFO - PID 4203 | Values: 165.0 163.0 163.0 162.0 163.0 174.0 164.0 161.0 165.0 173.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:30.77 (41.0%) stddev-sans-first:32.41 18:12:22 INFO - PID 4203 | Values: 77.0 75.0 75.0 172.0 78.0 74.0 73.0 73.0 100.0 77.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:81.50 stddev:25.78 (31.6%) stddev-sans-first:26.72 18:12:22 INFO - PID 4203 | Values: 82.0 81.0 142.0 82.0 83.0 81.0 133.0 81.0 82.0 129.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:12:22 INFO - PID 4203 | Values: 113.0 113.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 114.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 18:12:22 INFO - PID 4203 | Values: 149.0 150.0 153.0 150.0 150.0 150.0 150.0 151.0 149.0 149.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:12:22 INFO - PID 4203 | Values: 95.0 95.0 96.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:2.21 (3.9%) stddev-sans-first:2.06 18:12:22 INFO - PID 4203 | Values: 60.0 56.0 56.0 55.0 57.0 59.0 55.0 55.0 56.0 61.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 18:12:22 INFO - PID 4203 | Values: 53.0 54.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 55.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:76.50 stddev:7.74 (10.1%) stddev-sans-first:8.10 18:12:22 INFO - PID 4203 | Values: 76.0 77.0 76.0 77.0 77.0 100.0 75.0 85.0 76.0 76.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:131.50 stddev:9.22 (7.0%) stddev-sans-first:9.61 18:12:22 INFO - PID 4203 | Values: 138.0 133.0 126.0 135.0 130.0 127.0 128.0 129.0 128.0 157.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:184.50 stddev:5.21 (2.8%) stddev-sans-first:5.50 18:12:22 INFO - PID 4203 | Values: 185.0 184.0 185.0 182.0 181.0 188.0 195.0 178.0 181.0 177.0 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:4.09 (5.8%) stddev-sans-first:4.14 18:12:22 INFO - PID 4203 | Values: 67.0 68.0 68.0 75.0 73.0 79.0 68.0 68.0 72.0 67.0 18:12:22 INFO - PID 4203 | -------- Summary: end -------- 18:12:22 INFO - PID 4203 | 18:12:22 INFO - PID 4203 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:12:22 INFO - TEST-INFO | 4203: exit 0 18:12:22 INFO - TEST-OK | kraken | took 61558ms 18:12:22 INFO - SUITE-END | took 1174s 18:12:23 INFO - Completed test suite (00:19:34) 18:12:23 INFO - javascript benchmark 18:12:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8302.480581196995, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.1557071805264, 3107.1144723753728, 3156.984215078924, 3157.1317887580926, 3165.430222559939, 5879.176915231866, 5886.617369870955, 5891.263592050988, 5932.1991531143285, 5940.881182376355, 5894.705264736756, 5929.28848538176, 5935.554833387491, 5959.731812068457, 5970.16417701521, 5452.809151679692, 5456.645318054314, 5470.234167216593, 5480.150576660624, 5496.0931446311315, 5457.590680698943, 5467.699276539789, 5467.890642187173, 5480.04099282626, 5510.752016159283, 5509.724513774316, 5514.228008078872, 5523.6409633373705, 5531.944680553183, 5533.778648854041, 5503.889922201573, 5519.724013799334, 5520.392756796769, 5523.171524271352, 5541.085720856054, 5408.918866216971, 5463.071277882769, 5490.011797876381, 5496.065668836308, 5606.159076138571, 5965.28416590012, 6028.306744724369, 6043.365446628085, 6078.6048906820915, 6105.755769769204, 6378.425941665272, 6418.871622567569, 6488.6106833589665, 6500.577462464925, 6503.512236582275, 6296.464800491918, 6369.617822930639, 6380.808575742735, 6386.776462823779, 6387.648679322635, 5906.704664766745, 5942.524598032147, 5952.077427998667, 5963.13534537494, 5990.311114221877, 6420.0, 6479.6760161991715, 6511.706973186218, 6539.280679125292, 6557.0, 6303.432691057827, 6317.526185536011, 6324.3991820776955, 6417.454516366068, 6424.068510066014, 6327.303996560375, 6417.7753778617525, 6436.806895793134, 6494.025896115526, 6507.479401647857, 6220.471259942865, 6221.377862213742, 6298.937010629835, 6307.400796924285, 6399.9040014399825, 6268.686565671698, 6283.937160628427, 6296.590721603081, 6319.368063193736, 6377.489800815923, 5210.713410762369, 5220.660657057279, 5294.047071527085, 5305.973470132624, 5343.251944727741, 4388.692791504628, 4418.917365245536, 4440.245158323029, 4461.0, 4512.34570987205, 5478.068728316196, 5504.311961004874, 5512.200730893998, 5545.1682247663175, 5558.055130627803, 6339.714712837934, 6379.585326953733, 6394.488440924715, 6426.1003459515705, 6433.163688720437, 5491.176323551499, 5527.944720552743, 5534.225208470817, 5540.778368865281, 5644.8024319148635, 5620.971895140498, 5760.0, 5801.8549536261935, 5806.709664516842, 5821.039528477839, 6169.074638804125, 6172.814815555541, 6183.81448556544, 6191.721372538246, 6220.626762394271, 6313.55805093639, 6325.936740632719, 6346.873062538816, 6403.871922561616, 6417.26201486835, 6190.721417536131, 6199.194104766532, 6222.564420490703, 6233.719482623203, 6234.1583886174785, 6296.527760418078, 6298.11826344303, 6343.794679010974, 6371.96814015927, 6385.45723613498, 6479.0, 6530.053142294436, 6591.044298576776, 6591.670416479061, 6607.702653380513, 6137.6931153441255, 6227.816714824169, 6280.968595157177, 6284.842878928063, 6376.330485298977, 6185.103160041859, 6194.969025154845, 6197.81406557804, 6207.81376558704, 6207.875842483216, 6083.452489275809, 6142.600730952652, 6143.600665956698, 6155.815325540241, 6168.1056246844855, 5351.678899266057, 6210.503159747119, 6216.471599914058, 6360.93639063622, 6413.2945376007665, 6071.5446341523675, 6134.539909506894, 6156.384361563808, 6223.813285601439, 6253.3121356651645], "value": 5850.710623380981, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.961031753571, 904.1184844776344, 1171.6192237522807, 1207.9698007549816, 1216.1730023583964, 30977.225569360777, 36818.63181368189, 38229.80885095578, 41474.17051658965, 41855.58144418555, 42905.0, 43335.78332108343, 43397.56602433975, 43407.56592434082, 43453.34819977703, 7588.089429268482, 7666.118396384431, 7673.117591476968, 7720.845583088335, 7734.1105772836, 7608.6195690215545, 7690.884636730453, 7712.922870771276, 7728.806779830493, 7736.419768517356, 7491.325780679737, 7548.66031028605, 7721.30508254257, 7737.961310193441, 7738.0, 7613.619319034054, 7665.118511371208, 7681.193474685134, 7701.152873183945, 7707.614619269014, 7454.329110380092, 7593.392528597754, 7629.961850190713, 7644.044494438195, 7650.311471967494, 38752.0, 38817.41773873366, 38823.22353552941, 39114.0, 39135.804320978496, 3493.545839040934, 3530.505729197914, 3536.4341705327283, 3541.8937431876825, 3546.4325707886615, 31303.843480782678, 31407.685923140703, 31430.371392572248, 31609.841950790098, 31673.366532669217, 4807.19730101212, 4846.273059041137, 4882.389701287339, 4884.3650325457465, 4976.726280054596, 213198.0, 215902.0, 219471.0, 221359.0, 222366.0, 50142.24786628131, 50191.0, 50472.242916356285, 50490.495095049315, 50597.747011264706, 44645.77677111659, 46095.76952115218, 46105.538944610125, 52717.73641131847, 53047.46952530425, 14394.0, 16292.755608665879, 16515.17424128813, 16573.83426165723, 16657.33370665184, 13732.45070197201, 13782.0, 13857.307134643228, 13869.861301387058, 13889.0, 14338.139711617336, 14491.347889345005, 14508.927455362656, 14537.92731036338, 14543.127412355292, 5619.971900140473, 5627.380988091307, 5805.390434004453, 5876.853078673067, 5887.76448942046, 990.663174520652, 1002.4185972136144, 1013.3463915774431, 1042.2652030318607, 1052.3002203534563, 22907.541849162924, 23057.30828075127, 23921.28236152918, 29058.41883162325, 29458.116256512338, 1109.1681239070697, 1113.0205419231024, 1115.866096068477, 1116.2799994003822, 1124.4321617583232, 12605.432755526022, 12619.621411357673, 12694.238345699288, 12757.617271481871, 12765.872341276468, 224618.0, 225877.0, 227085.0, 227485.0, 227727.0, 51926.74036629868, 52339.476605234224, 52524.73737631287, 52649.2102618461, 52743.20885186725, 1407.1627381707867, 1480.8445113263167, 1484.9777253341208, 1502.2638906935522, 1507.0580886945659, 22137.889310553343, 22387.0, 22566.774332257122, 23150.421239468473, 23363.76636233616, 37947.81026094852, 38146.2370752589, 38327.42508862425, 38400.231995359376, 38454.80772596119, 196512.0, 196932.0, 197769.0, 197964.0, 198021.0, 34360.312793743484, 36180.27639447249, 36903.0, 38669.22661546697, 38770.4184437228, 46436.606901793, 47762.28356574724, 48016.519834801205, 48303.27545086897, 49050.0, 34325.82837085899, 34651.13372165716, 35228.295434091684, 35312.29375412529, 35759.82120089383, 33560.66439335576, 36581.63418365782, 36596.45105323369, 36820.263594728494, 36937.81531092327, 40680.38979415252, 40923.38614920838, 41456.0, 41778.79110604428, 41874.37188442115, 40912.79543602263, 42248.0, 42742.0, 42826.57173428226, 43067.0, 29693.703062969093, 30378.84810575933, 30737.0, 30966.380672386877, 31692.683073168973], "value": 17916.48223309459, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2129229724537, 571.2060236271581, 579.9971000144999, 587.1632923084604, 594.2927915780222, 21611.45971350715, 22404.0, 22515.211967581137, 22556.774432255672, 22561.77438225617, 24379.0, 25806.225813225585, 26920.192394228154, 27008.459830803422, 27267.86366068167, 6598.604083754978, 6751.459883209356, 6769.492288078389, 6783.0, 6806.965965170167, 6690.933090669104, 6727.6636168191635, 6746.19045714515, 6749.35881091298, 6761.053452516651, 5865.618734782247, 6234.407731265523, 6391.648459334735, 6421.133147025139, 6724.462043036546, 6320.178376811031, 6334.904976425334, 6377.872442551123, 6381.3937675920715, 6383.010633351838, 5913.733881975321, 5962.0, 5965.433283838029, 5974.253218347707, 5980.342162362137, 27071.86464067667, 29113.854430727923, 29212.123636290944, 29288.853555732298, 29617.259568510744, 1886.3209244671907, 1908.2557802457052, 1913.5024893527643, 1937.0, 1937.7577802774654, 18868.15093320804, 19260.807391926042, 19352.0, 19393.4181974541, 19408.514787130294, 2270.3189043286948, 2322.372959300996, 2365.9053637854636, 2376.988115059431, 2393.664886915833, 125332.0, 129321.35339323337, 130829.34585327108, 131241.0, 131318.0, 14094.577162685136, 14990.325435355435, 15349.002314849498, 15432.839402483662, 15620.84379156194, 23373.649395259086, 23417.41456463602, 23435.296941091452, 23485.41286467852, 23501.17745878886, 10111.0, 10126.59493620247, 10210.38737675727, 10291.485425728684, 10344.5344959477, 9408.905910940939, 9451.716448506555, 9559.330846840794, 9579.952100239454, 9583.712488625353, 9195.310351723647, 9251.67619133327, 9256.305777066747, 9558.90441095594, 9628.855567166358, 2610.2983412168314, 2726.209399274228, 2740.7259274072435, 2814.9859250703616, 2820.252633052243, 938.7090002099235, 951.46242373059, 953.8426159683713, 986.9654562090436, 989.3618615992789, 19658.46564416257, 19799.01004949747, 19903.303384381477, 20518.076686549142, 20631.484212894797, 1001.4942454060653, 1028.9382637041651, 1050.2910535388583, 1053.757635743783, 1054.1672079057612, 10808.405537695502, 10987.175961802737, 11083.944580277048, 11095.0, 11349.69631085005, 437344.0, 475433.0, 478381.0, 484957.0, 490084.0, 108879.45560272149, 112551.0, 112668.43665781783, 115228.0, 115344.0, 1201.0632683775445, 1210.933398663082, 1241.2366394667215, 1242.521629172757, 1244.7572723319047, 16724.163791810603, 17848.643027139125, 17922.91038544851, 18031.63936721232, 18043.278268869097, 56712.43287567236, 57747.42252577421, 58556.0, 60990.0, 62150.0, 68945.31054689389, 69657.0, 70034.29965700278, 70587.64706176436, 70743.64628176826, 14867.479638212611, 15429.768553471931, 15440.84559154394, 15452.5364239073, 15468.613284667523, 20581.794182057987, 23747.881260593585, 24069.398265043514, 24228.757712422652, 24652.0, 18514.351997680016, 18793.90603046976, 18941.14764835613, 18961.14674839608, 19075.236990520778, 15824.0, 16419.671606567565, 17236.138193090046, 17294.135293235035, 17571.56071098233, 17876.731849022013, 19048.42854714361, 19293.903530482257, 19343.4196974091, 19429.0, 14814.703705925605, 15167.544973650809, 15189.316480758613, 15265.465708700141, 15294.388224470897, 17248.827511725223, 18551.72172417388, 18741.34405295808, 18791.34230301933, 19004.14481348315], "value": 11993.529493965849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.6925607110365, 1383.1908333624829, 1388.7153133607612, 1401.9509317173902, 1413.1309244814436, 12674.112812103145, 13190.406431710571, 13283.33583320835, 13359.866401335983, 13370.598882033542, 13266.535671251508, 13524.729505409887, 13543.661408464794, 13548.390322435489, 13567.0, 2585.818992670509, 2628.8554129522868, 2632.197179860142, 2644.2596073099467, 2656.933576660589, 2548.4903019396197, 2631.302704783234, 2637.815352925296, 2640.7227241139594, 2647.0735242665105, 2555.0, 2567.974320256792, 2598.8440693558355, 2604.2708041748247, 2629.1455277034943, 2482.7641374069526, 2535.657686212356, 2550.8341957772686, 2554.706208785995, 2556.7826734727664, 2465.7287698353166, 2480.9255722328357, 2490.489449662815, 2494.301595553248, 2503.5618766715934, 12581.182223155465, 12818.423170957236, 12827.166234194841, 12827.422765975554, 12830.935845320808, 6789.117414736102, 7075.39859111971, 7080.256573059857, 7093.432525397956, 7117.572945623279, 4640.582347588733, 4722.173619616553, 4760.452547956995, 4857.927131093036, 4874.049560335736, 1856.7400563921062, 1858.2938483376365, 1886.8867867927968, 1925.1433112265047, 1931.58470928751, 19047.333343332917, 19736.802631973496, 20434.0, 20569.794302056936, 20608.896955515127, 5377.946220537823, 5475.67145971243, 5806.129080637938, 6023.6385816851125, 6032.276126864805, 14771.482998095014, 14794.334254958552, 14824.407023719146, 14826.0, 14867.330970106155, 6941.409980151744, 6966.860662786716, 6970.407515361251, 6982.092327997328, 6983.650817459208, 6358.173437453194, 6543.509236807164, 6558.770443034471, 6562.409383155539, 6587.4071333580205, 4507.166174257773, 4620.1221767864, 4676.298555216745, 4705.153072446924, 4726.527347265246, 1326.7611829870716, 1334.1461464662623, 1352.8985326100583, 1365.7678194706923, 1369.2537567025995, 868.6612221233723, 880.9911900881037, 886.1935638568872, 899.9685011024714, 920.7882187097006, 7076.823079423056, 7156.60638664868, 7226.205117437078, 7264.963675181696, 7341.641796267708, 703.5426972467936, 706.9010338552607, 718.6801873166495, 720.5280541245493, 720.8342081321325, 4264.744115353089, 5166.844994650167, 5305.814296499681, 5332.466753324637, 5390.380106287748, 17843.73234401485, 17964.371247006293, 18091.909540452212, 18184.9090754548, 18229.088545572667, 17047.232874520676, 17463.825361746472, 17479.126043697765, 17568.472945811645, 17948.0, 10159.238057145743, 10319.535620897077, 10344.482775861177, 10407.635732749317, 10410.271281010257, 7482.999970131693, 7898.565578893216, 7970.123286438603, 8068.394870384627, 8197.549134797644, 14458.843292536361, 14879.776803348175, 15747.291371888063, 15769.921150394175, 15890.920545397199, 14809.777853332424, 15147.697046058796, 15438.0, 15545.611359716098, 16012.439564615182, 10322.12261957742, 10642.148628109579, 10670.89329106699, 10706.197035222234, 10712.303700259457, 12155.088368372584, 12321.568745093879, 12338.50645974187, 12371.195872268274, 12374.690632733893, 9748.22014238845, 10010.849837252592, 10150.54322555472, 10324.845127323246, 10329.173666106542, 9528.761780955532, 9884.604615815288, 9933.106020458194, 9935.850962235716, 10060.195184385379, 8899.822003560022, 9174.816503670023, 9188.95405522968, 9202.401843880127, 9267.907320926704, 6852.0, 7019.859602808017, 7024.262452442625, 7064.894026589503, 7107.2120087031, 6568.540202185993, 6733.6296503692765, 6776.7628133015105, 6785.287544807724, 6918.515703900679], "value": 5974.932764164796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.966192366534, 504.2083928232674, 521.9269302297678, 522.156716902203, 527.4303751947897, 6012.789552365668, 6044.455998960093, 6073.817785466437, 6081.665508397036, 6123.663198524079, 5779.248697669308, 5953.315368732597, 5978.760849566023, 5981.222441082664, 6023.819285421433, 4842.0, 4899.730514821684, 4903.362562866841, 4921.4340350859575, 4945.134601444751, 4838.298446725223, 4865.34317867087, 4874.65877388583, 4886.193778026622, 4917.893473968365, 4837.5646191842725, 4879.39007624047, 4898.142825005628, 4908.386451693538, 4920.655554111214, 4684.391029166203, 4804.279358096279, 4808.68743531671, 4879.341288926021, 4907.975460122677, 4385.627221686161, 4388.981068708398, 4410.536893626155, 4422.336649502568, 4423.292273236267, 5777.364489906107, 5859.501942334907, 5866.882662346729, 5894.322152952423, 5903.675297858616, 5546.168074788774, 5576.1356989666665, 5602.943970560283, 5656.575756818214, 5687.857803554903, 6303.338149494329, 6303.842403939892, 6305.527085468562, 6344.809655710336, 6389.936100638981, 4818.951810481885, 4832.685875418087, 4838.395200599925, 4858.732769697665, 4892.6575139740235, 6682.83292917676, 6721.361470660279, 6725.596464212114, 6766.357196066366, 6894.413974812147, 4955.835378686006, 4966.279889416014, 4982.053409852117, 4982.153033984159, 4984.327115839388, 5026.346574945233, 5027.3464449621315, 5029.1450453423, 5075.847724568269, 5088.262201980692, 5515.503604675599, 5567.638103523258, 5568.415316391802, 5575.4424557543925, 5636.464535869086, 6359.395857393541, 6393.936060639334, 6409.391107844747, 6410.1987251593555, 6518.641474718936, 1718.4276387105908, 1765.7439671247598, 1766.5495298699007, 1768.32803534656, 1770.7255375416573, 1122.1583812140893, 1218.4151607228403, 1232.6133100262205, 1232.7103130764262, 1235.8269842222096, 5443.83668489938, 5524.309461317335, 5584.035334912258, 5654.858628534237, 5668.744906479218, 6482.902756458562, 6508.674566271668, 6585.6707164641575, 6624.012796161132, 6657.13457250564, 5611.242482264842, 5655.123455864347, 5675.886482270332, 5684.289463817023, 5693.629914055573, 3490.650934906489, 3519.102628829632, 3526.947095793565, 3527.8236088195486, 3564.8752293669595, 6419.679016049179, 6441.742330306829, 6472.3204063573585, 6481.09264702942, 6514.413702766774, 6740.39336459721, 6799.626020568916, 6816.318368163244, 6842.278827608934, 6843.213030501456, 6418.293987661354, 6425.004124360731, 6449.3873082057125, 6477.481801455872, 6524.249711283073, 6511.413972742476, 6547.247066587403, 6586.176727909012, 6665.666716664245, 6671.46628269747, 6511.283758786435, 6517.543771935919, 6539.771108011197, 6551.541392102507, 6566.9014964776525, 6272.0, 6274.403931626488, 6343.270523889812, 6391.776287829904, 6427.967860160669, 4871.196252618278, 4912.852614421573, 4924.138275801792, 4939.678920870132, 4949.82675606352, 6589.4069533742195, 6616.206055273398, 6640.273528882429, 6649.301823308483, 6664.866702666017, 6406.519511036598, 6413.839654008687, 6443.194600674916, 6445.387688169616, 6483.578567393104, 6404.847127516905, 6425.06836508713, 6474.125992991075, 6505.121808555785, 6511.34886511345, 6365.61806291624, 6371.74513019474, 6374.840628984312, 6383.585066970632, 6418.19772528434, 5921.911171332347, 6374.322784430643, 6399.488040956805, 6418.614883107029, 6450.967745161244, 6148.723307451265, 6157.6613286269685, 6183.443490085914, 6211.3167551570195, 6226.346233645583], "value": 4967.395495515537, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.5820522559623, 917.6512925088465, 929.7210836748978, 929.9953500232498, 934.1219253901337, 16624.0, 16908.239129239184, 17498.475045748648, 17514.737278940825, 17570.29718811249, 19759.70360444591, 20642.48393790156, 21649.783502164973, 21760.0, 21770.455738606543, 1020.6070662794822, 1060.0724366179593, 1066.695991642382, 1068.9358638481715, 1070.7430216747964, 1059.8357254625546, 1073.2862646340175, 1073.7100982734657, 1073.726199819045, 1075.1237741240864, 1003.4481035430521, 1043.9164866810636, 1102.101787043557, 1104.0560320925613, 1105.7567335186245, 1073.924825262232, 1079.7462596289865, 1083.5611577311201, 1084.8372744088372, 1086.7337502311905, 752.1838804896639, 789.1319548496665, 795.562440657636, 801.4309840013598, 803.7146812881401, 19352.70970935437, 19484.90257548703, 19510.80489195104, 19585.1186696599, 19681.606367872704, 16945.40691075819, 19587.80412195874, 20563.691544626843, 20694.379168624964, 20783.792162078338, 15857.048577085412, 16564.83435165657, 16586.917065414596, 16723.91638041814, 16748.162591870358, 3525.8589656413715, 3566.4293713005795, 3577.6601222883783, 3582.6417358264225, 3592.5329707138167, 111776.0, 113972.4301378496, 115075.42462287718, 115473.99999999916, 117296.41351793271, 15824.841751582337, 16159.272832722556, 16248.75626865598, 16478.588035299214, 16740.242274560995, 30120.84939575288, 30416.0, 30948.22629434282, 30996.53505197424, 31900.202494937814, 8562.186592273723, 8760.605772740242, 8763.912360876437, 8785.69250076257, 8803.955980220058, 3923.0976875318265, 4164.8125834337525, 4236.491621005499, 4244.0026593750445, 4272.33778764292, 5032.974835125801, 5098.0, 5110.156824124052, 5155.690658560424, 5160.638755287094, 817.750586071254, 845.6067928413318, 845.8266055458616, 985.5959056786826, 996.7059717383389, 705.2172088981226, 712.0814149746768, 715.2811424518326, 722.7795522365728, 733.8899165125274, 11058.612948546923, 11386.487608057658, 11557.711057223636, 11727.35499547516, 11954.402279885971, 679.6465837764433, 701.2391555162706, 702.8242939265184, 716.9390601798801, 731.3856360657073, 5111.488851114858, 5184.585233181337, 5236.450172731808, 5504.366997795225, 5708.315002199763, 97405.0, 99882.0, 101792.0, 103092.0, 105202.0, 85791.0, 89805.55097224603, 91412.0, 92688.53655731813, 94808.52595736977, 73509.63245183846, 75534.62232688801, 78454.0, 80140.0, 81414.59292703499, 10799.352038877692, 10895.346279222955, 10999.670009899715, 11255.437228138724, 11365.374904380338, 35625.28749424945, 35892.461613076346, 36477.63522364743, 36621.26757464889, 36957.26085478222, 44011.55988440075, 45148.32277515905, 45910.62268131961, 46389.53610463852, 46896.0, 16449.25978331002, 16686.49940501787, 16706.331746729993, 16748.078855663054, 16976.40582579604, 18020.459386218434, 18496.0, 18528.629427411644, 18535.258589656263, 18629.627407452048, 16310.184490775651, 16788.916055419646, 17246.396376126777, 18038.36865709694, 18115.72826407631, 17598.73601895947, 17613.911930440267, 17704.29182832672, 17807.554811129827, 17902.0, 16901.112953823365, 17900.641987160445, 18350.632987340447, 18382.448526544224, 18508.537286567942, 12823.294718790556, 12823.294718790556, 12950.870491295344, 12977.740445190855, 13058.21650700961, 12735.55425560101, 13012.804807928078, 13155.210687358789, 13303.26832024248, 13454.663633409244], "value": 8777.011461418313, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 109.0, 109.0, 108.0, 109.0, 108.0, 108.0, 109.0, 110.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 144.0, 173.0, 122.0, 153.0, 152.0, 125.0, 169.0, 122.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 163.0, 174.0, 164.0, 161.0, 165.0, 173.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 172.0, 78.0, 74.0, 73.0, 73.0, 100.0, 77.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 142.0, 82.0, 83.0, 81.0, 133.0, 81.0, 82.0, 129.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 153.0, 150.0, 150.0, 150.0, 150.0, 151.0, 149.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 56.0, 55.0, 57.0, 59.0, 55.0, 55.0, 56.0, 61.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 77.0, 77.0, 100.0, 75.0, 85.0, 76.0, 76.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 126.0, 135.0, 130.0, 127.0, 128.0, 129.0, 128.0, 157.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 182.0, 181.0, 188.0, 195.0, 178.0, 181.0, 177.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 75.0, 73.0, 79.0, 68.0, 68.0, 72.0, 67.0], "value": 70.5, "unit": "score"}]}]} 18:12:23 INFO - Return code: 0 18:12:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:12:23 INFO - # TBPL SUCCESS # 18:12:23 INFO - Running post-action listener: _package_coverage_data 18:12:23 INFO - Running post-action listener: _resource_record_post_action 18:12:23 INFO - [mozharness: 2017-07-17 01:12:23.353365Z] Finished run-tests step (success) 18:12:23 INFO - Running post-run listener: _resource_record_post_run 18:12:23 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 5861376; Write bytes: 439136256; Read time: 3168; Write time: 346532 18:12:23 INFO - TinderboxPrint: CPU usage
13.1% 18:12:23 INFO - TinderboxPrint: I/O read bytes / time
5,861,376 / 3,168 18:12:23 INFO - TinderboxPrint: I/O write bytes / time
439,136,256 / 346,532 18:12:23 INFO - TinderboxPrint: CPU idle
8,275.1 (86.9%) 18:12:23 INFO - TinderboxPrint: CPU user
1,197.6 (12.6%) 18:12:23 INFO - TinderboxPrint: Swap in / out
0 / 0 18:12:23 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112824320; Read time: 68; Write time: 71424 18:12:23 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:12:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 3694592; Write bytes: 254509056; Read time: 2660; Write time: 228840 18:12:23 INFO - Running post-run listener: _upload_blobber_files 18:12:23 INFO - Blob upload gear active. 18:12:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:12:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:12:24 INFO - Traceback (most recent call last): 18:12:24 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 18:12:24 INFO - main() 18:12:24 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 18:12:24 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 18:12:24 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 18:12:24 INFO - return set(response.json().get('whitelist', [])) 18:12:24 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 18:12:24 INFO - return json.loads(self.text or self.content, **kwargs) 18:12:24 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 18:12:24 INFO - return _default_decoder.decode(s) 18:12:24 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 18:12:24 INFO - obj, end = self.raw_decode(s) 18:12:24 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 18:12:24 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 18:12:24 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 18:12:24 ERROR - Return code: 1 18:12:24 INFO - Setting buildbot property blobber_files to {} 18:12:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:12:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:12:24 INFO - Contents: 18:12:24 INFO - blobber_files:{} 18:12:24 INFO - Running post-run listener: copy_logs_to_upload_dir 18:12:24 INFO - Copying logs to upload dir... 18:12:24 INFO - mkdir: /builds/slave/test/build/upload/logs 18:12:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.231573 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-07-16 18:12:24.432317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:24.440819) ========= 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=41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010918 build_url: 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/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 18:12:24.493483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:24.493811) ========= 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=41bf3e9aed84707956354da8000001c5-1500247303.915191-1518699536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:24.543405) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 18:12:24.543711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 18:12:24.543997) ========= ========= Total master_lag: 0.20 =========