builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1500424486.13 results: success (0) revision: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:46.131667) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:46.132091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:46.132742) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:46.164026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:46.164346) ========= 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=ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 17:34:47-- 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% 222M=0s 2017-07-18 17:34:47 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143474 ========= master_lag: 0.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:47.058175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:47.058495) ========= 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=ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020995 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:47.126613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:47.126944) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 --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 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 --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=ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 17:34:48,071 truncating revision to first 12 chars 2017-07-18 17:34:48,071 Setting DEBUG logging. 2017-07-18 17:34:48,071 attempt 1/10 2017-07-18 17:34:48,071 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b065ffd8a53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-18 17:34:48,616 unpacking tar archive at: mozilla-central-1b065ffd8a53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899061 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:48.050445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:48.055765) ========= script_repo_revision: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:48.056146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:48.056416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 17:34:48.071948) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-07-18 17:34:48.072221) ========= /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=ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:34:49 INFO - MultiFileLogger online at 20170718 17:34:49 in /builds/slave/test 17:34:49 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:34:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:49 INFO - {'append_to_log': False, 17:34:49 INFO - 'base_work_dir': '/builds/slave/test', 17:34:49 INFO - 'blob_upload_branch': 'Firefox', 17:34:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:49 INFO - 'branch': 'Firefox', 17:34:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:49 INFO - 'code_coverage': False, 17:34:49 INFO - 'config_files': ('talos/linux_config.py',), 17:34:49 INFO - 'default_actions': ('clobber', 17:34:49 INFO - 'read-buildbot-config', 17:34:49 INFO - 'download-and-extract', 17:34:49 INFO - 'populate-webroot', 17:34:49 INFO - 'create-virtualenv', 17:34:49 INFO - 'install', 17:34:49 INFO - 'setup-mitmproxy', 17:34:49 INFO - 'run-tests'), 17:34:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:49 INFO - 'disable_ccov_upload': False, 17:34:49 INFO - 'download_minidump_stackwalk': True, 17:34:49 INFO - 'download_symbols': 'ondemand', 17:34:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:49 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:49 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:49 INFO - 'gecko_profile': False, 17:34:49 INFO - 'gecko_profile_interval': 0, 17:34:49 INFO - 'installer_path': 'installer.exe', 17:34:49 INFO - 'log_level': 'info', 17:34:49 INFO - 'log_name': 'talos', 17:34:49 INFO - 'log_to_console': True, 17:34:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:34:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:34:49 INFO - 'opt_config_files': (), 17:34:49 INFO - 'pip_index': False, 17:34:49 INFO - 'suite': 'dromaeojs-e10s', 17:34:49 INFO - 'system_bits': '32', 17:34:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:49 INFO - 'title': 'talos-linux64-ix-035', 17:34:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:49 INFO - 'use_talos_json': True, 17:34:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:49 INFO - 'work_dir': 'build'} 17:34:49 INFO - [mozharness: 2017-07-19 00:34:49.118261Z] Running clobber step. 17:34:49 INFO - Running pre-action listener: _resource_record_pre_action 17:34:49 INFO - Running main action method: clobber 17:34:49 INFO - rmtree: /builds/slave/test/build 17:34:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:50 INFO - Running post-action listener: _resource_record_post_action 17:34:50 INFO - [mozharness: 2017-07-19 00:34:50.161877Z] Finished clobber step (success) 17:34:50 INFO - [mozharness: 2017-07-19 00:34:50.161981Z] Running read-buildbot-config step. 17:34:50 INFO - Running pre-action listener: _resource_record_pre_action 17:34:50 INFO - Running main action method: read_buildbot_config 17:34:50 INFO - Using buildbot properties: 17:34:50 INFO - { 17:34:50 INFO - "project": "", 17:34:50 INFO - "product": "firefox", 17:34:50 INFO - "who": "kwierso@gmail.com", 17:34:50 INFO - "installer_path": "public/build/target.tar.bz2", 17:34:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:34:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:34:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 17:34:50 INFO - "stage_platform": "linux64-pgo", 17:34:50 INFO - "basedir": "/builds/slave/test", 17:34:50 INFO - "buildnumber": 77, 17:34:50 INFO - "platform": "ubuntu64_hw", 17:34:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:34:50 INFO - "slavebuilddir": "test", 17:34:50 INFO - "taskId": "BXt76cn9RNi14cpVcRGgcg", 17:34:50 INFO - "branch": "mozilla-central", 17:34:50 INFO - "script_repo_revision": "production", 17:34:50 INFO - "revision": "1b065ffd8a535a0ad4c39a912af18e948e6a42c1", 17:34:50 INFO - "slavename": "talos-linux64-ix-035", 17:34:50 INFO - "repo_path": "mozilla-central" 17:34:50 INFO - } 17:34:50 INFO - Finding installer, test and symbols from parent task. 17:34:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXt76cn9RNi14cpVcRGgcg'}, attempt #1 17:34:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXt76cn9RNi14cpVcRGgcg'}, attempt #1 17:34:51 INFO - Task dependencies: BWHLihj4QTOZAHkuysZsLA 17:34:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA'}, attempt #1 17:34:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2 17:34:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/test_packages.json 17:34:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.crashreporter-symbols.zip 17:34:51 INFO - Running post-action listener: _resource_record_post_action 17:34:51 INFO - [mozharness: 2017-07-19 00:34:51.563359Z] Finished read-buildbot-config step (success) 17:34:51 INFO - [mozharness: 2017-07-19 00:34:51.563581Z] Running download-and-extract step. 17:34:51 INFO - Running pre-action listener: _resource_record_pre_action 17:34:51 INFO - Running main action method: download_and_extract 17:34:51 INFO - mkdir: /builds/slave/test/build/tests 17:34:51 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:34:51 INFO - trying https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.test_packages.json 17:34:51 INFO - Downloading https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:34:52 INFO - Downloaded 989 bytes. 17:34:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:34:52 INFO - Using the following test package requirements: 17:34:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:34:52 INFO - u'common': [u'target.common.tests.zip'], 17:34:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:34:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:34:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:34:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:34:52 INFO - u'mozbase': [u'target.common.tests.zip'], 17:34:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:34:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:34:52 INFO - u'web-platform': [u'target.common.tests.zip', 17:34:52 INFO - u'target.web-platform.tests.tar.gz'], 17:34:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:34:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:34:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.common.tests.zip 17:34:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:34:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.common.tests.zip into memory 17:34:54 INFO - Content-Length response header: 73366464 17:34:54 INFO - Bytes received: 73366464 17:35:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:35:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.common.tests.zip 17:35:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:35:05 INFO - Fetch https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.common.tests.zip into memory 17:35:07 INFO - Content-Length response header: 73366464 17:35:07 INFO - Bytes received: 73366464 17:35:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.talos.tests.zip 17:35:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:35:19 INFO - Fetch https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.talos.tests.zip into memory 17:35:20 INFO - Content-Length response header: 14495033 17:35:20 INFO - Bytes received: 14495033 17:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:20 INFO - trying https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2 17:35:20 INFO - Downloading https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:35:23 INFO - Downloaded 62680391 bytes. 17:35:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2 17:35:23 INFO - mkdir: /builds/slave/test/properties 17:35:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:35:23 INFO - Writing to file /builds/slave/test/properties/build_url 17:35:23 INFO - Contents: 17:35:23 INFO - build_url:https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2 17:35:23 INFO - Running post-action listener: _resource_record_post_action 17:35:23 INFO - Running post-action listener: set_extra_try_arguments 17:35:23 INFO - [mozharness: 2017-07-19 00:35:23.269505Z] Finished download-and-extract step (success) 17:35:23 INFO - [mozharness: 2017-07-19 00:35:23.269738Z] Running populate-webroot step. 17:35:23 INFO - Running pre-action listener: _resource_record_pre_action 17:35:23 INFO - Running main action method: populate_webroot 17:35:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:35:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:35:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:35:23 INFO - '--tppagecycles', 17:35:23 INFO - '7'], 17:35:23 INFO - 'tests': ['tsvgm']}}, 17:35:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:35:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:35:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:35:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:35:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:35:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['damp', 'tps']}, 17:35:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'tests': ['damp', 'tps']}, 17:35:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['dromaeo_dom']}, 17:35:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:35:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:35:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:35:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:35:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['a11yr', 17:35:23 INFO - 'ts_paint', 17:35:23 INFO - 'tpaint', 17:35:23 INFO - 'sessionrestore', 17:35:23 INFO - 'sessionrestore_no_auto_restore', 17:35:23 INFO - 'tabpaint']}, 17:35:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:35:23 INFO - 'ts_paint', 17:35:23 INFO - 'tpaint', 17:35:23 INFO - 'sessionrestore', 17:35:23 INFO - 'sessionrestore_many_windows', 17:35:23 INFO - 'sessionrestore_no_auto_restore', 17:35:23 INFO - 'tabpaint']}, 17:35:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:35:23 INFO - 'ts_paint', 17:35:23 INFO - 'tpaint', 17:35:23 INFO - 'sessionrestore', 17:35:23 INFO - 'sessionrestore_many_windows', 17:35:23 INFO - 'sessionrestore_no_auto_restore', 17:35:23 INFO - 'tabpaint']}, 17:35:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:35:23 INFO - 'ts_paint', 17:35:23 INFO - 'tpaint', 17:35:23 INFO - 'sessionrestore', 17:35:23 INFO - 'sessionrestore_many_windows', 17:35:23 INFO - 'sessionrestore_no_auto_restore', 17:35:23 INFO - 'tabpaint']}, 17:35:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['a11yr', 17:35:23 INFO - 'ts_paint', 17:35:23 INFO - 'tpaint', 17:35:23 INFO - 'sessionrestore', 17:35:23 INFO - 'sessionrestore_no_auto_restore', 17:35:23 INFO - 'tabpaint']}, 17:35:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['a11yr', 17:35:23 INFO - 'ts_paint', 17:35:23 INFO - 'tpaint', 17:35:23 INFO - 'sessionrestore', 17:35:23 INFO - 'sessionrestore_no_auto_restore', 17:35:23 INFO - 'tabpaint']}, 17:35:23 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:35:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:35:23 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:35:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:35:23 INFO - 'talos_options': ['--mitmproxy', 17:35:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:35:23 INFO - '--firstNonBlankPaint'], 17:35:23 INFO - 'tests': ['quantum_pageload_google', 17:35:23 INFO - 'quantum_pageload_youtube', 17:35:23 INFO - 'quantum_pageload_amazon', 17:35:23 INFO - 'quantum_pageload_facebook']}, 17:35:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['tsvgx', 17:35:23 INFO - 'tsvgr_opacity', 17:35:23 INFO - 'tart', 17:35:23 INFO - 'tscrollx', 17:35:23 INFO - 'cart', 17:35:23 INFO - 'tsvg_static']}, 17:35:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:35:23 INFO - 'tsvgr_opacity', 17:35:23 INFO - 'tart', 17:35:23 INFO - 'tscrollx', 17:35:23 INFO - 'cart', 17:35:23 INFO - 'tsvg_static']}, 17:35:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'talos_options': ['--disable-e10s'], 17:35:23 INFO - 'tests': ['tp5o']}, 17:35:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:35:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'talos_options': ['--disable-e10s', 17:35:23 INFO - '--xperf_path', 17:35:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:35:23 INFO - 'tests': ['tp5n']}, 17:35:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:35:23 INFO - 'talos_options': ['--xperf_path', 17:35:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:35:23 INFO - 'tests': ['tp5n']}}, 17:35:23 INFO - 'talos.zip': {'path': '', 17:35:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:35:23 INFO - Running post-action listener: _resource_record_post_action 17:35:23 INFO - [mozharness: 2017-07-19 00:35:23.292412Z] Finished populate-webroot step (success) 17:35:23 INFO - [mozharness: 2017-07-19 00:35:23.292504Z] Running create-virtualenv step. 17:35:23 INFO - Running pre-action listener: _resource_record_pre_action 17:35:23 INFO - Running main action method: create_virtualenv 17:35:23 INFO - Creating virtualenv /builds/slave/test/build/venv 17:35:23 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:35:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:35:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:35:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:35:23 INFO - Using real prefix '/usr' 17:35:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:35:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:35:25 INFO - Installing pip.................done. 17:35:25 INFO - Return code: 0 17:35:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:35:26 INFO - Reading from file tmpfile_stdout 17:35:26 INFO - Output received: 17:35:26 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:35:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:35: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:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35: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:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:26 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:26 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:35:26 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:35:26 INFO - Using env: {'DISPLAY': ':0', 17:35:26 INFO - 'HOME': '/home/cltbld', 17:35:26 INFO - 'LANG': 'en_US.UTF-8', 17:35:26 INFO - 'LANGUAGE': 'en_US:en', 17:35:26 INFO - 'LOGNAME': 'cltbld', 17:35:26 INFO - 'MAIL': '/var/mail/cltbld', 17:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:26 INFO - 'MOZ_NO_REMOTE': '1', 17:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:26 INFO - 'NO_EM_RESTART': '1', 17:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:26 INFO - 'PWD': '/builds/slave/test', 17:35:26 INFO - 'SHELL': '/bin/bash', 17:35:26 INFO - 'SHLVL': '1', 17:35:26 INFO - 'TERM': 'linux', 17:35:26 INFO - 'TMOUT': '86400', 17:35:26 INFO - 'USER': 'cltbld', 17:35:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:26 INFO - '_': '/tools/buildbot/bin/python'} 17:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:26 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:35:26 INFO - Cleaning up... 17:35:26 INFO - Return code: 0 17:35:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:35: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:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35: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:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:26 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:26 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:35:26 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:35:26 INFO - Using env: {'DISPLAY': ':0', 17:35:26 INFO - 'HOME': '/home/cltbld', 17:35:26 INFO - 'LANG': 'en_US.UTF-8', 17:35:26 INFO - 'LANGUAGE': 'en_US:en', 17:35:26 INFO - 'LOGNAME': 'cltbld', 17:35:26 INFO - 'MAIL': '/var/mail/cltbld', 17:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:26 INFO - 'MOZ_NO_REMOTE': '1', 17:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:26 INFO - 'NO_EM_RESTART': '1', 17:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:26 INFO - 'PWD': '/builds/slave/test', 17:35:26 INFO - 'SHELL': '/bin/bash', 17:35:26 INFO - 'SHLVL': '1', 17:35:26 INFO - 'TERM': 'linux', 17:35:26 INFO - 'TMOUT': '86400', 17:35:26 INFO - 'USER': 'cltbld', 17:35:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:26 INFO - '_': '/tools/buildbot/bin/python'} 17:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:26 INFO - Downloading/unpacking psutil>=3.1.1 17:35: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:35: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:35: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:35: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:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:35:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:27 INFO - Installing collected packages: psutil 17:35:27 INFO - Running setup.py install for psutil 17:35:27 INFO - building 'psutil._psutil_linux' extension 17:35:27 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:35:27 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:35:27 INFO - building 'psutil._psutil_posix' extension 17:35:27 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:35:28 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:35:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:28 INFO - Successfully installed psutil 17:35:28 INFO - Cleaning up... 17:35:28 INFO - Return code: 0 17:35:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:35: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:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35: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:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:35: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 mozsystemmonitor==0.3 17:35:28 INFO - Using env: {'DISPLAY': ':0', 17:35:28 INFO - 'HOME': '/home/cltbld', 17:35:28 INFO - 'LANG': 'en_US.UTF-8', 17:35:28 INFO - 'LANGUAGE': 'en_US:en', 17:35:28 INFO - 'LOGNAME': 'cltbld', 17:35:28 INFO - 'MAIL': '/var/mail/cltbld', 17:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:28 INFO - 'MOZ_NO_REMOTE': '1', 17:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:28 INFO - 'NO_EM_RESTART': '1', 17:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:28 INFO - 'PWD': '/builds/slave/test', 17:35:28 INFO - 'SHELL': '/bin/bash', 17:35:28 INFO - 'SHLVL': '1', 17:35:28 INFO - 'TERM': 'linux', 17:35:28 INFO - 'TMOUT': '86400', 17:35:28 INFO - 'USER': 'cltbld', 17:35:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:28 INFO - '_': '/tools/buildbot/bin/python'} 17:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:35:29 INFO - Installing collected packages: mozsystemmonitor 17:35:29 INFO - Running setup.py install for mozsystemmonitor 17:35:29 INFO - Successfully installed mozsystemmonitor 17:35:29 INFO - Cleaning up... 17:35:29 INFO - Return code: 0 17:35:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:35:29 INFO - Using env: {'DISPLAY': ':0', 17:35:29 INFO - 'HOME': '/home/cltbld', 17:35:29 INFO - 'LANG': 'en_US.UTF-8', 17:35:29 INFO - 'LANGUAGE': 'en_US:en', 17:35:29 INFO - 'LOGNAME': 'cltbld', 17:35:29 INFO - 'MAIL': '/var/mail/cltbld', 17:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:29 INFO - 'MOZ_NO_REMOTE': '1', 17:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:29 INFO - 'NO_EM_RESTART': '1', 17:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:29 INFO - 'PWD': '/builds/slave/test', 17:35:29 INFO - 'SHELL': '/bin/bash', 17:35:29 INFO - 'SHLVL': '1', 17:35:29 INFO - 'TERM': 'linux', 17:35:29 INFO - 'TMOUT': '86400', 17:35:29 INFO - 'USER': 'cltbld', 17:35:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:29 INFO - '_': '/tools/buildbot/bin/python'} 17:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:29 INFO - Downloading/unpacking jsonschema==2.5.1 17:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:35:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:35:31 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:35:31 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:35:31 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:35:31 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:35:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:35:31 INFO - warning: no files found matching '*.txt' 17:35:31 INFO - no previously-included directories found matching 'build' 17:35:31 INFO - no previously-included directories found matching 'dist' 17:35:31 INFO - no previously-included directories found matching '.git*' 17:35:31 INFO - Installing collected packages: jsonschema, functools32 17:35:31 INFO - Running setup.py install for functools32 17:35:31 INFO - warning: no files found matching '*.txt' 17:35:31 INFO - no previously-included directories found matching 'build' 17:35:31 INFO - no previously-included directories found matching 'dist' 17:35:31 INFO - no previously-included directories found matching '.git*' 17:35:31 INFO - Successfully installed jsonschema functools32 17:35:31 INFO - Cleaning up... 17:35:31 INFO - Return code: 0 17:35:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:31 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:31 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:35:31 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:35:31 INFO - Using env: {'DISPLAY': ':0', 17:35:31 INFO - 'HOME': '/home/cltbld', 17:35:31 INFO - 'LANG': 'en_US.UTF-8', 17:35:31 INFO - 'LANGUAGE': 'en_US:en', 17:35:31 INFO - 'LOGNAME': 'cltbld', 17:35:31 INFO - 'MAIL': '/var/mail/cltbld', 17:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:31 INFO - 'MOZ_NO_REMOTE': '1', 17:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:31 INFO - 'NO_EM_RESTART': '1', 17:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:31 INFO - 'PWD': '/builds/slave/test', 17:35:31 INFO - 'SHELL': '/bin/bash', 17:35:31 INFO - 'SHLVL': '1', 17:35:31 INFO - 'TERM': 'linux', 17:35:31 INFO - 'TMOUT': '86400', 17:35:31 INFO - 'USER': 'cltbld', 17:35:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:31 INFO - '_': '/tools/buildbot/bin/python'} 17:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:35:31 INFO - Cleaning up... 17:35:31 INFO - Return code: 0 17:35:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:31 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:31 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:35:31 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:35:31 INFO - Using env: {'DISPLAY': ':0', 17:35:31 INFO - 'HOME': '/home/cltbld', 17:35:31 INFO - 'LANG': 'en_US.UTF-8', 17:35:31 INFO - 'LANGUAGE': 'en_US:en', 17:35:31 INFO - 'LOGNAME': 'cltbld', 17:35:31 INFO - 'MAIL': '/var/mail/cltbld', 17:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:31 INFO - 'MOZ_NO_REMOTE': '1', 17:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:31 INFO - 'NO_EM_RESTART': '1', 17:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:31 INFO - 'PWD': '/builds/slave/test', 17:35:31 INFO - 'SHELL': '/bin/bash', 17:35:31 INFO - 'SHLVL': '1', 17:35:31 INFO - 'TERM': 'linux', 17:35:31 INFO - 'TMOUT': '86400', 17:35:31 INFO - 'USER': 'cltbld', 17:35:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:31 INFO - '_': '/tools/buildbot/bin/python'} 17:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:31 INFO - Downloading/unpacking blobuploader==1.2.4 17:35:31 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:35:31 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:35:31 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:35:31 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:35:32 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:33 INFO - Downloading docopt-0.6.1.tar.gz 17:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:33 INFO - Running setup.py install for blobuploader 17:35:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:33 INFO - Running setup.py install for requests 17:35:33 INFO - Running setup.py install for docopt 17:35:34 INFO - Successfully installed blobuploader requests docopt 17:35:34 INFO - Cleaning up... 17:35:34 INFO - Return code: 0 17:35:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:34 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:34 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:35:34 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:35:34 INFO - Using env: {'DISPLAY': ':0', 17:35:34 INFO - 'HOME': '/home/cltbld', 17:35:34 INFO - 'LANG': 'en_US.UTF-8', 17:35:34 INFO - 'LANGUAGE': 'en_US:en', 17:35:34 INFO - 'LOGNAME': 'cltbld', 17:35:34 INFO - 'MAIL': '/var/mail/cltbld', 17:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:34 INFO - 'MOZ_NO_REMOTE': '1', 17:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:34 INFO - 'NO_EM_RESTART': '1', 17:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:34 INFO - 'PWD': '/builds/slave/test', 17:35:34 INFO - 'SHELL': '/bin/bash', 17:35:34 INFO - 'SHLVL': '1', 17:35:34 INFO - 'TERM': 'linux', 17:35:34 INFO - 'TMOUT': '86400', 17:35:34 INFO - 'USER': 'cltbld', 17:35:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:34 INFO - '_': '/tools/buildbot/bin/python'} 17:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:34 INFO - Running setup.py (path:/tmp/pip-VAJeCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:34 INFO - Running setup.py (path:/tmp/pip-1_XSBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:34 INFO - Running setup.py (path:/tmp/pip-Nj23Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:34 INFO - Running setup.py (path:/tmp/pip-jiqHy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:34 INFO - Running setup.py (path:/tmp/pip-hazhqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:34 INFO - Running setup.py (path:/tmp/pip-VLREZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:34 INFO - Running setup.py (path:/tmp/pip-fYx1Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:34 INFO - Running setup.py (path:/tmp/pip-VPIzXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:34 INFO - Running setup.py (path:/tmp/pip-f1hKsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:34 INFO - Running setup.py (path:/tmp/pip-aYeLiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:35 INFO - Running setup.py (path:/tmp/pip-cMBwrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:35 INFO - Running setup.py (path:/tmp/pip-mnEBc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:35 INFO - Running setup.py (path:/tmp/pip-XpM6uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:35 INFO - Running setup.py (path:/tmp/pip-4To4Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:35 INFO - Running setup.py (path:/tmp/pip-sgIVXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:35 INFO - Running setup.py (path:/tmp/pip-SVjR_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:35 INFO - Running setup.py (path:/tmp/pip-o0ftEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:35 INFO - Running setup.py install for manifestparser 17:35:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:35 INFO - Running setup.py install for mozcrash 17:35:35 INFO - Running setup.py install for mozdebug 17:35:35 INFO - Running setup.py install for mozdevice 17:35:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:35 INFO - Running setup.py install for mozfile 17:35:36 INFO - Running setup.py install for mozhttpd 17:35:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Running setup.py install for mozinfo 17:35:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Running setup.py install for mozInstall 17:35:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Running setup.py install for mozleak 17:35:36 INFO - Running setup.py install for mozlog 17:35:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Running setup.py install for moznetwork 17:35:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Running setup.py install for mozprocess 17:35:36 INFO - Running setup.py install for mozprofile 17:35:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:36 INFO - Running setup.py install for mozrunner 17:35:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:37 INFO - Running setup.py install for mozscreenshot 17:35:37 INFO - Running setup.py install for moztest 17:35:37 INFO - Running setup.py install for mozversion 17:35:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:37 INFO - Cleaning up... 17:35:37 INFO - Return code: 0 17:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:37 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:37 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:35:37 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:35:37 INFO - Using env: {'DISPLAY': ':0', 17:35:37 INFO - 'HOME': '/home/cltbld', 17:35:37 INFO - 'LANG': 'en_US.UTF-8', 17:35:37 INFO - 'LANGUAGE': 'en_US:en', 17:35:37 INFO - 'LOGNAME': 'cltbld', 17:35:37 INFO - 'MAIL': '/var/mail/cltbld', 17:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:37 INFO - 'MOZ_NO_REMOTE': '1', 17:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:37 INFO - 'NO_EM_RESTART': '1', 17:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:37 INFO - 'PWD': '/builds/slave/test', 17:35:37 INFO - 'SHELL': '/bin/bash', 17:35:37 INFO - 'SHLVL': '1', 17:35:37 INFO - 'TERM': 'linux', 17:35:37 INFO - 'TMOUT': '86400', 17:35:37 INFO - 'USER': 'cltbld', 17:35:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:37 INFO - '_': '/tools/buildbot/bin/python'} 17:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:37 INFO - Running setup.py (path:/tmp/pip-FvDnNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:37 INFO - Running setup.py (path:/tmp/pip-VUR79F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:37 INFO - Running setup.py (path:/tmp/pip-jeFtrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:37 INFO - Running setup.py (path:/tmp/pip-O0IEE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:37 INFO - Running setup.py (path:/tmp/pip-IrH0dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:37 INFO - Running setup.py (path:/tmp/pip-uqs9vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:37 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:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:37 INFO - Running setup.py (path:/tmp/pip-qbj_k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:38 INFO - Running setup.py (path:/tmp/pip-846kwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:38 INFO - Running setup.py (path:/tmp/pip-l6ARQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:38 INFO - Running setup.py (path:/tmp/pip-JvXM9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:38 INFO - Running setup.py (path:/tmp/pip-WUzEZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:38 INFO - Running setup.py (path:/tmp/pip-DnkVmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:38 INFO - Running setup.py (path:/tmp/pip-eLWuPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:38 INFO - Running setup.py (path:/tmp/pip-uSqm6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:38 INFO - Running setup.py (path:/tmp/pip-4HiAfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:38 INFO - Running setup.py (path:/tmp/pip-4E56e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:38 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:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:38 INFO - Running setup.py (path:/tmp/pip-3em41I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:39 INFO - Downloading blessings-1.6.tar.gz 17:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:39 INFO - Installing collected packages: blessings 17:35:39 INFO - Running setup.py install for blessings 17:35:40 INFO - Successfully installed blessings 17:35:40 INFO - Cleaning up... 17:35:40 INFO - Return code: 0 17:35:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:40 INFO - Reading from file tmpfile_stdout 17:35:40 INFO - Current package versions: 17:35:40 INFO - argparse == 1.2.1 17:35:40 INFO - blessings == 1.6 17:35:40 INFO - blobuploader == 1.2.4 17:35:40 INFO - docopt == 0.6.1 17:35:40 INFO - functools32 == 3.2.3-2 17:35:40 INFO - jsonschema == 2.5.1 17:35:40 INFO - manifestparser == 1.1 17:35:40 INFO - mozInstall == 1.13 17:35:40 INFO - mozcrash == 1.0 17:35:40 INFO - mozdebug == 0.1 17:35:40 INFO - mozdevice == 0.51 17:35:40 INFO - mozfile == 1.2 17:35:40 INFO - mozhttpd == 0.7 17:35:40 INFO - mozinfo == 0.10 17:35:40 INFO - mozleak == 0.1 17:35:40 INFO - mozlog == 3.5 17:35:40 INFO - moznetwork == 0.27 17:35:40 INFO - mozprocess == 0.25 17:35:40 INFO - mozprofile == 0.28 17:35:40 INFO - mozrunner == 6.13 17:35:40 INFO - mozscreenshot == 0.1 17:35:40 INFO - mozsystemmonitor == 0.3 17:35:40 INFO - moztest == 0.8 17:35:40 INFO - mozversion == 1.4 17:35:40 INFO - psutil == 3.1.1 17:35:40 INFO - requests == 1.2.3 17:35:40 INFO - wsgiref == 0.1.2 17:35:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:40 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 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:40 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:35:40 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:35:40 INFO - Using env: {'DISPLAY': ':0', 17:35:40 INFO - 'HOME': '/home/cltbld', 17:35:40 INFO - 'LANG': 'en_US.UTF-8', 17:35:40 INFO - 'LANGUAGE': 'en_US:en', 17:35:40 INFO - 'LOGNAME': 'cltbld', 17:35:40 INFO - 'MAIL': '/var/mail/cltbld', 17:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:40 INFO - 'MOZ_NO_REMOTE': '1', 17:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:40 INFO - 'NO_EM_RESTART': '1', 17:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:40 INFO - 'PWD': '/builds/slave/test', 17:35:40 INFO - 'SHELL': '/bin/bash', 17:35:40 INFO - 'SHLVL': '1', 17:35:40 INFO - 'TERM': 'linux', 17:35:40 INFO - 'TMOUT': '86400', 17:35:40 INFO - 'USER': 'cltbld', 17:35:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:40 INFO - '_': '/tools/buildbot/bin/python'} 17:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:35:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:35:41 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:35:41 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:35:41 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:35:41 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:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:35:41 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:35:41 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:35:41 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:35:41 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:35:41 INFO - Installing collected packages: marionette-driver, simplejson 17:35:41 INFO - Running setup.py install for marionette-driver 17:35:42 INFO - Running setup.py install for simplejson 17:35:42 INFO - building 'simplejson._speedups' extension 17:35:42 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:35:42 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:35:43 INFO - Successfully installed marionette-driver simplejson 17:35:43 INFO - Cleaning up... 17:35:43 INFO - Return code: 0 17:35:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2196b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, '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': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', '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:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:35:43 INFO - Using env: {'DISPLAY': ':0', 17:35:43 INFO - 'HOME': '/home/cltbld', 17:35:43 INFO - 'LANG': 'en_US.UTF-8', 17:35:43 INFO - 'LANGUAGE': 'en_US:en', 17:35:43 INFO - 'LOGNAME': 'cltbld', 17:35:43 INFO - 'MAIL': '/var/mail/cltbld', 17:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:43 INFO - 'MOZ_NO_REMOTE': '1', 17:35:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:43 INFO - 'NO_EM_RESTART': '1', 17:35:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:43 INFO - 'PWD': '/builds/slave/test', 17:35:43 INFO - 'SHELL': '/bin/bash', 17:35:43 INFO - 'SHLVL': '1', 17:35:43 INFO - 'TERM': 'linux', 17:35:43 INFO - 'TMOUT': '86400', 17:35:43 INFO - 'USER': 'cltbld', 17:35:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:43 INFO - '_': '/tools/buildbot/bin/python'} 17:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:43 INFO - Cleaning up... 17:35:43 INFO - Return code: 0 17:35:43 INFO - Running post-action listener: _resource_record_post_action 17:35:43 INFO - Running post-action listener: _start_resource_monitoring 17:35:43 INFO - Starting resource monitoring. 17:35:43 INFO - [mozharness: 2017-07-19 00:35:43.359941Z] Finished create-virtualenv step (success) 17:35:43 INFO - [mozharness: 2017-07-19 00:35:43.360458Z] Running install step. 17:35:43 INFO - Running pre-action listener: _resource_record_pre_action 17:35:43 INFO - Running main action method: install 17:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:43 INFO - Reading from file tmpfile_stdout 17:35:43 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:43 INFO - Reading from file tmpfile_stdout 17:35:43 INFO - Output received: 17:35:43 INFO - Usage: mozinstall [options] installer 17:35:43 INFO - Options: 17:35:43 INFO - -h, --help show this help message and exit 17:35:43 INFO - -d DEST, --destination=DEST 17:35:43 INFO - Directory to install application into. [default: 17:35:43 INFO - "/builds/slave/test"] 17:35:43 INFO - --app=APP Application being installed. [default: firefox] 17:35:43 INFO - mkdir: /builds/slave/test/build/application 17:35:43 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:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:36:01 INFO - Reading from file tmpfile_stdout 17:36:01 INFO - Output received: 17:36:01 INFO - /builds/slave/test/build/application/firefox/firefox 17:36:01 INFO - Running post-action listener: _resource_record_post_action 17:36:01 INFO - [mozharness: 2017-07-19 00:36:01.422984Z] Finished install step (success) 17:36:01 INFO - [mozharness: 2017-07-19 00:36:01.423240Z] Running setup-mitmproxy step. 17:36:01 INFO - Running pre-action listener: _resource_record_pre_action 17:36:01 INFO - Running main action method: setup_mitmproxy 17:36:01 INFO - Skipping: mitmproxy is not required 17:36:01 INFO - Running post-action listener: _resource_record_post_action 17:36:01 INFO - [mozharness: 2017-07-19 00:36:01.424377Z] Finished setup-mitmproxy step (success) 17:36:01 INFO - [mozharness: 2017-07-19 00:36:01.424618Z] Running run-tests step. 17:36:01 INFO - Running pre-action listener: _resource_record_pre_action 17:36:01 INFO - Running pre-action listener: _set_gcov_prefix 17:36:01 INFO - Running main action method: run_tests 17:36:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:36:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:36:01 INFO - Python 2.7.3 17:36:01 INFO - Return code: 0 17:36:01 INFO - grabbing minidump binary from tooltool 17:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:01 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 0x2193d00>, '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 0x2194c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2195090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:36:01 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:36:01 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:36:01 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:36:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:36:01 INFO - Return code: 0 17:36:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:36:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:36:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:36:01 INFO - ENV: RUST_BACKTRACE is now 1 17:36:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:36:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:36:01 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/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:36:01 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/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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:36:01 INFO - Using env: {'DISPLAY': ':0', 17:36:01 INFO - 'HOME': '/home/cltbld', 17:36:01 INFO - 'LANG': 'en_US.UTF-8', 17:36:01 INFO - 'LANGUAGE': 'en_US:en', 17:36:01 INFO - 'LOGNAME': 'cltbld', 17:36:01 INFO - 'MAIL': '/var/mail/cltbld', 17:36:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:36:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:01 INFO - 'MOZ_NO_REMOTE': '1', 17:36:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:01 INFO - 'NO_EM_RESTART': '1', 17:36:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:01 INFO - 'PWD': '/builds/slave/test', 17:36:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:36:01 INFO - 'RUST_BACKTRACE': '1', 17:36:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:36:01 INFO - 'SHELL': '/bin/bash', 17:36:01 INFO - 'SHLVL': '1', 17:36:01 INFO - 'TERM': 'linux', 17:36:01 INFO - 'TMOUT': '86400', 17:36:01 INFO - 'USER': 'cltbld', 17:36:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089', 17:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:01 INFO - '_': '/tools/buildbot/bin/python'} 17:36:01 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/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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:36:01 INFO - mozversion application_buildid: 20170718233341 17:36:01 INFO - mozversion application_changeset: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 17:36:01 INFO - mozversion application_display_name: Nightly 17:36:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:36:01 INFO - mozversion application_name: Firefox 17:36:01 INFO - mozversion application_remotingname: firefox 17:36:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:36:01 INFO - mozversion application_vendor: Mozilla 17:36:01 INFO - mozversion application_version: 56.0a1 17:36:01 INFO - mozversion platform_buildid: 20170718233341 17:36:01 INFO - mozversion platform_changeset: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 17:36:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:36:01 INFO - mozversion platform_version: 56.0a1 17:36:01 INFO - using testdate: 1500424561 17:36:01 INFO - actual date: 1500424561 17:36:01 INFO - starting webserver on 'localhost:58464' 17:36:01 INFO - SUITE-START | Running 2 tests 17:36:01 INFO - TEST-START | dromaeo_css 17:36:01 INFO - Initialising browser for dromaeo_css test... 17:36:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58464/getInfo.html -profile /tmp/tmpiOLTUT/profile 17:36:01 INFO - TEST-INFO | started process 15524 (/builds/slave/test/build/application/firefox/firefox http://localhost:58464/getInfo.html) 17:36:07 INFO - TEST-INFO | 15524: exit 0 17:36:07 INFO - Browser initialized. 17:36:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:36:07 INFO - TEST-INFO | started process 15775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiOLTUT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:18 INFO - PID 15775 | RSS: Main: 165908480 17:36:18 INFO - PID 15775 | 17:39:15 INFO - PID 15775 | Cycle 1(1): loaded http://localhost:58464/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58464/tests/dromaeo/cssquery-ext.html) 17:39:18 INFO - PID 15775 | RSS: Main: 171855872 17:39:18 INFO - PID 15775 | 17:42:20 INFO - PID 15775 | Cycle 1(1): loaded http://localhost:58464/tests/dromaeo/cssquery-ext.html (next: http://localhost:58464/tests/dromaeo/cssquery-jquery.html) 17:42:20 INFO - PID 15775 | RSS: Main: 169111552 17:42:20 INFO - PID 15775 | 17:45:22 INFO - PID 15775 | Cycle 1(1): loaded http://localhost:58464/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58464/tests/dromaeo/cssquery-mootools.html) 17:45:22 INFO - PID 15775 | RSS: Main: 169222144 17:45:22 INFO - PID 15775 | 17:48:24 INFO - PID 15775 | Cycle 1(1): loaded http://localhost:58464/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58464/tests/dromaeo/cssquery-prototype.html) 17:48:25 INFO - PID 15775 | RSS: Main: 170803200 17:48:25 INFO - PID 15775 | 17:51:28 INFO - PID 15775 | Cycle 1(1): loaded http://localhost:58464/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58464/tests/dromaeo/cssquery-yui.html) 17:51:28 INFO - PID 15775 | RSS: Main: 171548672 17:51:28 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | Cycle 1(1): loaded http://localhost:58464/tests/dromaeo/cssquery-yui.html (next: http://localhost:58464/tests/dromaeo/cssquery-dojo.html) 17:54:30 INFO - PID 15775 | RSS: Main: 174014464 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | __start_tp_report 17:54:30 INFO - PID 15775 | _x_x_mozilla_page_load 17:54:30 INFO - PID 15775 | _x_x_mozilla_page_load_details 17:54:30 INFO - PID 15775 | |i|pagename|runs| 17:54:30 INFO - PID 15775 | |0;dojo.html;3354.2955979244357;3373.527706121142;3410.164509695125;3414.624391316955;3437.4500079987192;6250.437460628543;6271.310155882855;6288;6327.46216571592;6450.838729031777;6402.583832050914;6451.870962580757;6465.9676701616545;6492.480601551876;6502.089707440962;5560.748831512918;5570.913671833994;5629.408912064236;5643.351014633308;5654.349749778767;5461.044317244487;5495.807646732365;5542.501174894259;5572.721363931808;5577.470140336662;5528.391876893558;5533.6956467394275;5538.667679939196;5545.223668686407;5547.805826796083;5525;5529.142982837667;5543.916841247385;5545.334559852803;5552.5280351170195;5466.617336786427;5519.420460851593;5529.612927095105;5530.170474428827;5533.114701647757;6226.657533835637;6230.408111229426;6250.749970001195;6252.249730032425;6258.217722784606;6789.864202715968;6812.352826481526;6822.692978815965;6822.897656535156;6843.62360070196;6907.792766217021;6909.412699920513;6911.7926462206215;6916.896246556305;6925.722971081151;6313.053042043684;6374.776882809079;6429.7749578764515;6453.193350831146;6499.837504062389;7040.401565866856;7053.753118640823;7116.964415177943;7131.71473141079;7139.214686384494;6628.701708423133;6742.42689371409;6755.054292399068;6759.662016899136;6765.695543700545;6837.658117094125;6840.897386539206;6843.452523798084;6844.041834143224;6855.588664680035;6661.866762664719;6808.863822723617;6834.2140653825445;6874.896876546856;6888.621125838027;6893.655317234118;6913.792586222421;6925.58446493212;6996.580205187705;7007.824804379829;5079.6952182869145;5148.099082660594;5181.248718935733;5200.6879587224885;5202.4277329493725;4498.932516012197;4515.525869783691;4519.615832654261;4527.886802829889;4544.7045942013665;5505.421930697299;6343.460805831556;6384.712687928962;6403.743850246031;6504.642244676588;6926.030355750199;6933.237343892168;6999.335063168991;7018.438524917994;7035.437165026786;6420.807375778734;6428.325025872309;6460.224773027173;6482.124913136666;6498.805035848932;5661;5741.885162296814;5750.079987202028;5750.913736293959;5832.912506312408;7117.3594376505325;7152.499325047197;7153.213146553875;7155.463340249398;7160.427165826825;6845.5550389223545;6927.272636373108;6937.826554336182;6940.1671799382375;6949.2008419030435;6237.106312749263;7094.6097964612445;7154.034205382207;7156.463265255231;7159.463040272105;6844.965775171092;6848.794536163923;6896;6914.723411063501;6919.37725604698;6944.861102778017;6971.198312194163;7002.579845209304;7038.366547010589;7077.363037326665;6603.570767900071;6666.433353165035;6678.265390807104;6694.966525167343;6752.358525940028;6678.198616166092;6685;6708.161479815023;6708.19501659804;6722.05891175226;5657.943420565742;6665.566738162198;6733.42765864907;6774.254831968578;6787.389134977679;6624.8012559623285;6685.39831415175;6714.0600315954825;6750.122484077038;6765.2896445872475;6493.350664933469;6523.967380163069;6526.988316810902;6531.11829902957;6536.150300460909 17:54:30 INFO - PID 15775 | |1;ext.html;815.5863605811953;882.1743983394363;924.4129977464311;942.8632848237006;943.2359788571262;41379.379309310345;41779.16441671165;41781.7910910445;41896.37155442671;42128.789356053254;40026.7998660007;40225;40426.595734042654;40442.39336409956;40589.797051014706;6707.8658426831435;6773.72905083796;6795.592264464123;6803.387695107439;6836.692348844289;6656.301088385722;6732.25945146036;6734.292899245582;6735.292794256581;6736.494762892778;6695.799126026227;6702.865942681144;6705.061291419205;6726.293739157391;6753.223379311368;6683.866322673543;6689.264180940093;6703.564268322568;6711.832204194885;6734.629595372253;6138.7237574309265;6165.075238714184;6194.4425001749605;6209.844753881144;6228.564000519966;34795.30409391798;34859;35070;35091.29817403663;35153.64846351555;3273.1980664737293;3293.324868401996;3319.9170020749434;3382.3573521030926;3480.3561341151967;31663.683363166303;31947.361052779048;32001.359972800412;32044.19889502781;32096.35807283841;4982.725950072744;4989.126902791997;5023.020511000356;5030.597552195815;5086.389633243997;200695;202987;203178;206288;207265;51997.48002520002;52675.736621316646;52925.735371322895;52961.735191323794;53113.2033019505;55677.44322556723;56153.71923140358;56183.43816561864;56258.43741562614;56297;17004.234809433605;17263.913680431517;17278.568035799206;17281.222344994505;17282.913585432245;14136.575902722934;14146;14228.857711422961;14233.074850134708;14240.287985600886;15093.698126037418;15161.469348572748;15213.239338033054;15355.309011094527;15442.613934651723;5862.501687356537;5929.347771745104;5999.550033747487;6003.759849606055;6110.358412366726;1061.8141825180562;1084.5770149641646;1095.3427943233996;1095.4960718069617;1117.8155604325357;24923.875380623344;24941.62587561188;25128.497430051295;25187.99248030058;25387.492250154894;1166.0904494494307;1178.134071457478;1192.2488832035763;1202.5730865542782;1213.4418167642982;13296;13327.73344533104;13417.329133543284;13431.731365372638;13463.596092117252;243584;244864;244958;247326;247351;52167;52428.47571524312;52467.73766131145;52548.21177682338;52743.736281319114;1479.0829685594786;1553.223388305847;1555.440041585006;1556.533040087969;1562.5390509799636;24838.875805620857;28972.565411518422;29567;29808.956686515867;30119.54820677648;54897.45102548923;55087.44912550823;55288.44711552994;55328;55409.44590554043;219174;221319;221480;222524;222532;33609;34067.65932340645;34135;34277.828610856785;37371;40439.797801010805;40770;44655.776721116184;45753.54246457493;45827;32317.838410807795;33681.494777578846;33868.49197262093;34233.14417139492;34432;33259.334813304085;33705.49441758425;33790.49314260239;34137.658623413445;34158;39545.80227098846;39674.80162599284;42977.14045719131;43071.35392969046;43177.7841110805;32555.674443255266;33503.49744753782;34091;34562.135946601535;34805;24570.50858982846;25836.483270334113;25968.961241550125;25987.740122599287;26302.34244143835 17:54:30 INFO - PID 15775 | |2;jquery.html;566.4646908671305;567.1577707104951;571.5113577890903;589.7022003888037;592.7391947543082;22290.88854555727;23323.766762332394;23416.882915585396;23618;23628.291151265446;25432.491350172986;26611.467770644576;27641.30896727583;27775.861120694368;27900.720992790117;6250.937490625092;6367.172267605205;6399.8400039998905;6400.743970241185;6414.230292364923;6289.465395441393;6302.243730752293;6324.557280990332;6339.302676705582;6339.904901426482;6003.979323515013;6095.329513753483;6260.935640941051;6270.905936410934;6287.276963149227;6219.253689557259;6256.655883926383;6300.747970081215;6307.936920630781;6316.273628532732;5777.248957635523;5781.075027995501;5806.390329015435;5844.795432159854;5871.442212989759;28553.57169642457;30207.244818879484;30478.39043219123;30539.69460305413;30582;2168.4578855286177;2220.9555808883733;2227.4431392151964;2243.674667173267;2247.1123906057014;19552.413427597196;20200.393988180378;20202.09090590927;20204;20248.291309804234;2246.8539544929527;2286.8056215221727;2324;2325.744168141503;2331.6735657008035;152161;158777.20611396868;159141;160625;160693.19653401658;15081.321340539702;15649;15902.568768810863;15957.563819256091;16349.754753678704;24428.26715198547;24442.51114977726;24534.141305054236;24551.50896982086;24599.38501537476;10697.83953240702;10704.78590428187;10873.782524349468;10887.782244355069;10993.395363254938;9877.40735555869;9918.950405247928;9997.950010250048;10009.698739163861;10075.143612792996;9613.51932403391;9624.342749755187;9667.178289845302;9757.170640495495;10072.899271007196;2678.9460015582254;2727.399972006195;2758.4896794093156;2827.5334569795755;2889.197478445904;1027.3219675014454;1034.1726618705156;1036.3781730961364;1059.655611926127;1063.9255252132432;21262.043208055675;21322.573548528944;21618.02718877623;22032.669509957363;22233.666495002588;1104.7072525780675;1107.02028704597;1111.7220694826294;1132.422464543089;1138.1975707126455;11905.404729763477;11909.88090119105;11912.88087119135;12073.758524829454;12088.395580220953;572878;577199;593127;598914;601485;131766.34116829548;133084.3345783265;134391.3280433611;134676.3266183663;134934;1246.6883279180206;1264.2035517624022;1265.4432049898016;1292.1730092740654;1292.8254685617321;18115.72826407631;19154.329598463988;19393.612127757082;19485;19785.10967006517;61433.38566614276;62692.05961910484;63043.6847815758;63236.683816580626;63409;82677.17322826936;85661.57169214114;85694.14305856862;85957.57021214854;86863.56568217119;14678.77981830252;15246.390144394543;15389.461368852037;15478.845211547741;15657.921710391374;22825.771742282366;23096;23549.29352119439;24963.375915602257;25911.093111741;17602.295908164044;18683.439496815117;18806.153723082767;19023.239070437026;19126.7130993038;16612.335506580086;17105;17132.743008855126;17437.47687569375;17955.281788728305;18626.534336641693;18660.160292787128;18706.409955153966;18737.063146842876;18914.243430263185;14373.496927607901;15176.620584485476;15245.313960872008;15303.923480382527;15357.923210383877;17558.82441175623;17708.822911771233;17733.20200591002;17754;17808.46574602764 17:54:30 INFO - PID 15775 | |3;mootools.html;1421.289355322339;1510.4486862295262;1516.5374560758978;1525.8016457860476;1535.9385624575025;14286.571402857919;14917.627059323522;14934.775978360334;14935.253237338144;14990.475333363334;15248.161351125684;15795.210239488037;16306.429274975379;16415.17924103796;16507.58731031725;2751.17464760572;2822.760065394444;2823.2095013396283;2827.2083816531403;2831.5327970884778;2748.6564179477564;2775.098093119734;2777.847218402987;2778.1804367711475;2778.610994460777;2653.9516890828113;2696.5415879300467;2725.6320396746482;2730.7269273072734;2735.5212837753315;2613.098481024044;2711.1324376199623;2717.4836781011645;2720.6055122007197;2722.1153125234378;2742.9725702742917;2776.3891943772337;2777.125205560262;2783.958240626392;2789.734975177355;15570.844291557052;15627.296771645304;15658;15662.921685391613;15699.293531791096;8364.163583641648;8707.956460217658;8729.476231426072;8732.43239189457;8733.912660873437;4867.245576935581;5060.46865079165;5180.715060671661;5202.375714914235;5226.81706140287;1840.4264353977424;1851.278001579385;1869.9439016829517;1924.7209154672635;1937.2154277517627;26854.25447345916;26925.596116058077;26944.05695800657;26997.595036074476;27027.189184324503;7029.718811247493;7098.964505177544;7151.427885769126;7190.64046797658;7210.062691850026;17800.643987120184;17939.641207176046;17945.282188712306;17966.730499042525;18034.2786288547;8247.381446391544;8395.62219700115;8440.62017209227;8447.070822209553;8475.915240847513;7719.11230208522;7763.262490063548;7804.3366313862825;7815.843683126419;7827.726029588937;5353.892922141613;5491.780328786884;5564.248826408464;5604.187392828098;5619.634723742944;1577.9921100394424;1591.1248813152952;1618.5063555615416;1619.9757003644954;1631;951.8048799995984;952.7760976170595;964.6382606522554;974.4786539201493;982.916452101565;8935.865962010575;8979.102089791098;9011.774705632411;9070.682526111554;9081.636734530544;1003.2525768302661;1011.7824667696481;1040.5005597313182;1045.2996492350144;1061.6443491430302;5569.582281328917;5625.296837895263;5702.315722113373;5808.5933984621515;5895.233619629506;21242;21853.67219491709;21976;21985.450363741034;23312.7668723314;20265.594688106452;21118.683219751714;21148.682769758467;21225.36323910285;21364.465888352606;10852.728681783019;11771.823422648667;11898.464569094585;11905.880941190477;11914.821277680841;8683.348748843988;8800.823983520422;8835.072317406837;8932.374733768575;9025.638974441212;18798.906005469886;19702;20040.298589549297;20058.097385617973;20246;19300.22799088077;19811.900940495205;20499.4875128123;20601.48496287605;20827.271045513335;11964.64106076819;12284.754304914031;12291.631251062483;12314.261144331369;12344.4444999977;14790.704185916436;14793.92603036978;14805.925970370079;14850.925745371203;14938.551843444715;11787.11596630239;11992.220505667452;12008.579699710468;12071.336076515525;12506.249625022529;10804.837927431252;10950.288231264942;11048.668539943814;11065.944670276596;11291.943540282246;10361.222908281758;10370.585176592851;10431.426271555138;10486.056254937092;10488.580456781643;7447.878793915764;7478.813029674084;7547.358474529727;7566.924330756622;7766.844663106819;7965.920340796518;8056.033276006682;8112.472689275178;8165.037351976753;8282.1303763104 17:54:30 INFO - PID 15775 | |4;prototype.html;499.5953277844946;512.915368964121;534.2520471340123;538.281394338558;542.0514100324432;6219.689015549216;6226.719797609107;6243.157173781538;6271.717772700228;6281.748730050793;5988.550858685605;5989.610675306102;6184.9690751546295;6213.844653883655;6215.782447614334;4730.787114579835;4791.377120974268;4794.736289504076;4805.855824325267;4820.662553621248;4767.785449654774;4803.663743537936;4856.878578035542;4861.270809378604;4878.0731660984475;4540;4755.763501489603;4774.952250477486;4785.593224575915;4804.83183088592;4696.95303046972;4729.692569982957;4743.810247590092;4756.500567440438;4775.641826862964;4251.2347777400055;4302.827886884521;4314.676399270036;4325.935110973338;4348.543402942709;5982.162497250389;6002.609830361012;6020;6040.637561746309;6071.2714474263375;5654.519365853907;5700.743466543974;5715.571332150105;5729.914051289234;5792.855178620526;6458.257300410466;6508.349165083501;6531.4448271896945;6556.967215163942;6594.86810263792;4866.099771542276;4905.460399356068;4912.091263116335;4928.127311621561;4938.777755000998;6801.523893327469;6828.180618325783;6864.425840309884;6954.965225173842;6994.370506654425;5081.59347252219;5083.491650834887;5097.643164978416;5122.667026643257;5129.410117836422;5094.286799848024;5094.821681241138;5128.9230661540105;5151.304573882553;5220.755075317574;5673.121115840374;5678.943210567924;5692.6299790513485;5777.7977770777825;5788.27646544182;6539.542232043711;6542.934570654328;6549.901751473732;6596.076549283104;6672.065101120621;1766.2758269109604;1780.7328900664745;1787.6245988342594;1787.883787553805;1797.200245890566;1141.2923987127867;1153.5212886652114;1234.5864135514523;1242.27327013698;1253.4296894912793;6008.098785182257;6075.33171351151;6162.291336496271;6188.195534580565;6264.310925798159;6719.798406047827;6767.864642707118;6815.148106486689;6832.93167068323;6836.726530938806;6215.223097112861;6224.253089629183;6245.531585131042;6254.498200719658;6347.841303967438;3555.6977656898935;3563.1804684922613;3569.5002699622073;3603.819809009539;3615.4757560154158;6960.886258198664;7004.2645522220455;7066.611336376446;7071.727089123904;7106.289371062956;6887.5178737488895;6929.688164032631;6979.708753880548;6988.44092472601;7029.859402811915;6998.145491444873;7081.388491869184;7089.397401220954;7099.858002839915;7119.430445564342;6705.463562914858;6777.220619628806;6802.897956530557;6861.387573920025;6884.5180837342905;6671.633060181736;6706.966465167643;6734.427573656294;6760.864782704417;6788.592684438752;6766.515244648911;6823.727050917908;6905.309469053054;6926.896096558455;7052.576845389293;5057.8735531612;5071.340725705634;5072.26097907126;5082.593392528663;5083.593312535062;6859;6878.174619045746;6905.896411553931;6913.861722765617;6927.965360173167;6609.339066093352;6628.304028076983;6636;6638.47315117516;6662.433693136138;6649.700763465559;6653.800385988428;6658.600483970784;6662.234507855519;6684.364985326386;6236.723595887378;6502.707378168088;6611.867762644816;6649.135612370361;6650.301718319507;6049;6360.300366959538;6466.612003279818;6514.250861150838;6585.143931289093;6377.4579160771855;6388.744450221939;6442.423030787535;6460.25707043696;6472.770173666988 17:54:30 INFO - PID 15775 | |5;yui.html;927.4435338796718;945.2135463973092;957.3681370295602;961.8509131084684;965.165132160681;18604.441866744004;21058.789412105893;21756;22528.77471225287;22583;20573;20687.275945341917;21359.145634174616;21386.786132138674;21566.353009409704;1061.3207547169836;1073.0557109743415;1074.1621535202555;1077.49357801833;1077.9083777878889;1027.6403258859414;1029.8558201851747;1031.566741968375;1036.0882423467338;1036.7874585709949;1075.1989767623093;1134.279732369947;1137.7212582917198;1138.049728476723;1138.464921486904;842.4145219072716;847.817719190377;856.6573370651727;858.8625819868822;1067.9466026698633;804.6178065418937;811.9837603247902;812.3420029775841;814.0109766633509;814.242754238558;18232.817671823246;18280.17739201739;18410.723839142425;18477.815221847744;18498.075096245135;21032.789672103238;21209.681854772192;21530;21552.676709849366;21603.45991350213;16033.839661603351;16453.753193702105;16462.259198335985;16519.83480165195;16659.750103748454;3690.9815450922843;3691.261747650454;3701.8149092545264;3717.0893131183034;3722.4602432647116;137614;138439;138824.30587847097;141987.37527998304;144413;15783.447579334897;16265.186740662919;16483.91758041202;16524.75212871808;16923;30210.09369718912;30941.845290773403;32062.19844503906;32263.193420164684;32775;8878.200961913459;9112.635494580276;9186.632534698538;9216.262698984065;9218.631254749735;4197.538270790211;4221.303484925014;4235.639970602533;4255.3829694694095;4275.700700950903;5475.370332411744;5602.963451761437;5616.073347897551;5622.240997465372;5641.633293835887;1127.2391135983178;1130.8529891114104;1134.5235001299475;1145.118258940611;1147.8048731715628;696.5472442912046;697.9895301570481;705.8200158959432;721.7798571435658;735.0224201811578;12282.385880706108;12670;12893.871061289266;13235.404406801717;13348.265845378402;713.9857202856018;717.2791344698545;718.3678363040491;720.1969803668871;745.3515441565872;5704.201411802351;5922.970385148046;5971.820845374646;5993.250843644544;6014.127951447016;117822;122158.38920805338;122443;123987.3800630991;125050;106097.46951265194;108099.45950270198;108569;109183;109610;93150.53424732969;95019.12309754653;98813.50593246988;100240;101794.49102754291;11670.183087183816;11706.1220408468;11714.589989350332;11776.234544754563;11858.584949526725;46481.30278045764;46632.533674662816;46652.7667361661;47573;49077.2638410417;57936.71031644983;58108;60713;61331.693341533006;61539.38460615516;16301.67396652084;16400;16605.75091373606;16615.086170260267;16744.916275418545;14987.625309366917;15325.157116358707;15344.846551534789;15392.538223853302;15411.845881541489;15969.600759980629;16026;16092.195390230676;16099.67800644004;16164.757528637316;15671.921640391725;15707.607309817346;15807.209639517749;15980.121093339978;16032.759508607147;14746.926265368604;15746.291416886039;15876.206189690238;15989.280482378554;16006.279717412977;10264.230182736474;10685.893141068489;10810.837837432287;10824.458777060958;12566.811497827723;14463.13221206731;14475.565733028026;14540.41838326455;14561.41754329815;14714.779278311047 17:54:30 INFO - PID 15775 | __end_tp_report 17:54:30 INFO - PID 15775 | __start_cc_report 17:54:30 INFO - PID 15775 | _x_x_mozilla_cycle_collect,332 17:54:30 INFO - PID 15775 | __end_cc_report 17:54:30 INFO - PID 15775 | __startTimestamp1500425670614__endTimestamp 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | ------- Summary: start ------- 17:54:30 INFO - PID 15775 | Number of tests: 6 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | [#0] dojo.html Cycles:165 Average:6299.69 Median:6603.57 stddev:827.52 (12.5%) stddev-sans-first:797.14 17:54:30 INFO - PID 15775 | Values: 3354.3 3373.5 3410.2 3414.6 3437.5 6250.4 6271.3 6288.0 6327.5 6450.8 6402.6 6451.9 6466.0 6492.5 6502.1 5560.7 5570.9 5629.4 5643.4 5654.3 5461.0 5495.8 5542.5 5572.7 5577.5 5528.4 5533.7 5538.7 5545.2 5547.8 5525.0 5529.1 5543.9 5545.3 5552.5 5466.6 5519.4 5529.6 5530.2 5533.1 6226.7 6230.4 6250.7 6252.2 6258.2 6789.9 6812.4 6822.7 6822.9 6843.6 6907.8 6909.4 6911.8 6916.9 6925.7 6313.1 6374.8 6429.8 6453.2 6499.8 7040.4 7053.8 7117.0 7131.7 7139.2 6628.7 6742.4 6755.1 6759.7 6765.7 6837.7 6840.9 6843.5 6844.0 6855.6 6661.9 6808.9 6834.2 6874.9 6888.6 6893.7 6913.8 6925.6 6996.6 7007.8 5079.7 5148.1 5181.2 5200.7 5202.4 4498.9 4515.5 4519.6 4527.9 4544.7 5505.4 6343.5 6384.7 6403.7 6504.6 6926.0 6933.2 6999.3 7018.4 7035.4 6420.8 6428.3 6460.2 6482.1 6498.8 5661.0 5741.9 5750.1 5750.9 5832.9 7117.4 7152.5 7153.2 7155.5 7160.4 6845.6 6927.3 6937.8 6940.2 6949.2 6237.1 7094.6 7154.0 7156.5 7159.5 6845.0 6848.8 6896.0 6914.7 6919.4 6944.9 6971.2 7002.6 7038.4 7077.4 6603.6 6666.4 6678.3 6695.0 6752.4 6678.2 6685.0 6708.2 6708.2 6722.1 5657.9 6665.6 6733.4 6774.3 6787.4 6624.8 6685.4 6714.1 6750.1 6765.3 6493.4 6524.0 6527.0 6531.1 6536.2 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | [#1] ext.html Cycles:180 Average:40270.96 Median:34497.07 stddev:58274.51 (168.9%) stddev-sans-first:58362.68 17:54:30 INFO - PID 15775 | Values: 815.6 882.2 924.4 942.9 943.2 41379.4 41779.2 41781.8 41896.4 42128.8 40026.8 40225.0 40426.6 40442.4 40589.8 6707.9 6773.7 6795.6 6803.4 6836.7 6656.3 6732.3 6734.3 6735.3 6736.5 6695.8 6702.9 6705.1 6726.3 6753.2 6683.9 6689.3 6703.6 6711.8 6734.6 6138.7 6165.1 6194.4 6209.8 6228.6 34795.3 34859.0 35070.0 35091.3 35153.6 3273.2 3293.3 3319.9 3382.4 3480.4 31663.7 31947.4 32001.4 32044.2 32096.4 4982.7 4989.1 5023.0 5030.6 5086.4 200695.0 202987.0 203178.0 206288.0 207265.0 51997.5 52675.7 52925.7 52961.7 53113.2 55677.4 56153.7 56183.4 56258.4 56297.0 17004.2 17263.9 17278.6 17281.2 17282.9 14136.6 14146.0 14228.9 14233.1 14240.3 15093.7 15161.5 15213.2 15355.3 15442.6 5862.5 5929.3 5999.6 6003.8 6110.4 1061.8 1084.6 1095.3 1095.5 1117.8 24923.9 24941.6 25128.5 25188.0 25387.5 1166.1 1178.1 1192.2 1202.6 1213.4 13296.0 13327.7 13417.3 13431.7 13463.6 243584.0 244864.0 244958.0 247326.0 247351.0 52167.0 52428.5 52467.7 52548.2 52743.7 1479.1 1553.2 1555.4 1556.5 1562.5 24838.9 28972.6 29567.0 29809.0 30119.5 54897.5 55087.4 55288.4 55328.0 55409.4 219174.0 221319.0 221480.0 222524.0 222532.0 33609.0 34067.7 34135.0 34277.8 37371.0 40439.8 40770.0 44655.8 45753.5 45827.0 32317.8 33681.5 33868.5 34233.1 34432.0 33259.3 33705.5 33790.5 34137.7 34158.0 39545.8 39674.8 42977.1 43071.4 43177.8 32555.7 33503.5 34091.0 34562.1 34805.0 24570.5 25836.5 25969.0 25987.7 26302.3 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | [#2] jquery.html Cycles:180 Average:39504.63 Median:12259.17 stddev:99162.26 (808.9%) stddev-sans-first:99397.34 17:54:30 INFO - PID 15775 | Values: 566.5 567.2 571.5 589.7 592.7 22290.9 23323.8 23416.9 23618.0 23628.3 25432.5 26611.5 27641.3 27775.9 27900.7 6250.9 6367.2 6399.8 6400.7 6414.2 6289.5 6302.2 6324.6 6339.3 6339.9 6004.0 6095.3 6260.9 6270.9 6287.3 6219.3 6256.7 6300.7 6307.9 6316.3 5777.2 5781.1 5806.4 5844.8 5871.4 28553.6 30207.2 30478.4 30539.7 30582.0 2168.5 2221.0 2227.4 2243.7 2247.1 19552.4 20200.4 20202.1 20204.0 20248.3 2246.9 2286.8 2324.0 2325.7 2331.7 152161.0 158777.2 159141.0 160625.0 160693.2 15081.3 15649.0 15902.6 15957.6 16349.8 24428.3 24442.5 24534.1 24551.5 24599.4 10697.8 10704.8 10873.8 10887.8 10993.4 9877.4 9919.0 9998.0 10009.7 10075.1 9613.5 9624.3 9667.2 9757.2 10072.9 2678.9 2727.4 2758.5 2827.5 2889.2 1027.3 1034.2 1036.4 1059.7 1063.9 21262.0 21322.6 21618.0 22032.7 22233.7 1104.7 1107.0 1111.7 1132.4 1138.2 11905.4 11909.9 11912.9 12073.8 12088.4 572878.0 577199.0 593127.0 598914.0 601485.0 131766.3 133084.3 134391.3 134676.3 134934.0 1246.7 1264.2 1265.4 1292.2 1292.8 18115.7 19154.3 19393.6 19485.0 19785.1 61433.4 62692.1 63043.7 63236.7 63409.0 82677.2 85661.6 85694.1 85957.6 86863.6 14678.8 15246.4 15389.5 15478.8 15657.9 22825.8 23096.0 23549.3 24963.4 25911.1 17602.3 18683.4 18806.2 19023.2 19126.7 16612.3 17105.0 17132.7 17437.5 17955.3 18626.5 18660.2 18706.4 18737.1 18914.2 14373.5 15176.6 15245.3 15303.9 15357.9 17558.8 17708.8 17733.2 17754.0 17808.5 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | [#3] mootools.html Cycles:180 Average:9705.19 Median:2633.53 stddev:6828.16 (259.3%) stddev-sans-first:6818.95 17:54:30 INFO - PID 15775 | Values: 1421.3 1510.4 1516.5 1525.8 1535.9 14286.6 14917.6 14934.8 14935.3 14990.5 15248.2 15795.2 16306.4 16415.2 16507.6 2751.2 2822.8 2823.2 2827.2 2831.5 2748.7 2775.1 2777.8 2778.2 2778.6 2654.0 2696.5 2725.6 2730.7 2735.5 2613.1 2711.1 2717.5 2720.6 2722.1 2743.0 2776.4 2777.1 2784.0 2789.7 15570.8 15627.3 15658.0 15662.9 15699.3 8364.2 8708.0 8729.5 8732.4 8733.9 4867.2 5060.5 5180.7 5202.4 5226.8 1840.4 1851.3 1869.9 1924.7 1937.2 26854.3 26925.6 26944.1 26997.6 27027.2 7029.7 7099.0 7151.4 7190.6 7210.1 17800.6 17939.6 17945.3 17966.7 18034.3 8247.4 8395.6 8440.6 8447.1 8475.9 7719.1 7763.3 7804.3 7815.8 7827.7 5353.9 5491.8 5564.2 5604.2 5619.6 1578.0 1591.1 1618.5 1620.0 1631.0 951.8 952.8 964.6 974.5 982.9 8935.9 8979.1 9011.8 9070.7 9081.6 1003.3 1011.8 1040.5 1045.3 1061.6 5569.6 5625.3 5702.3 5808.6 5895.2 21242.0 21853.7 21976.0 21985.5 23312.8 20265.6 21118.7 21148.7 21225.4 21364.5 10852.7 11771.8 11898.5 11905.9 11914.8 8683.3 8800.8 8835.1 8932.4 9025.6 18798.9 19702.0 20040.3 20058.1 20246.0 19300.2 19811.9 20499.5 20601.5 20827.3 11964.6 12284.8 12291.6 12314.3 12344.4 14790.7 14793.9 14805.9 14850.9 14938.6 11787.1 11992.2 12008.6 12071.3 12506.2 10804.8 10950.3 11048.7 11065.9 11291.9 10361.2 10370.6 10431.4 10486.1 10488.6 7447.9 7478.8 7547.4 7566.9 7766.8 7965.9 8056.0 8112.5 8165.0 8282.1 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | [#4] prototype.html Cycles:180 Average:5578.04 Median:6217.74 stddev:1608.14 (25.9%) stddev-sans-first:1566.83 17:54:30 INFO - PID 15775 | Values: 499.6 512.9 534.3 538.3 542.1 6219.7 6226.7 6243.2 6271.7 6281.7 5988.6 5989.6 6185.0 6213.8 6215.8 4730.8 4791.4 4794.7 4805.9 4820.7 4767.8 4803.7 4856.9 4861.3 4878.1 4540.0 4755.8 4775.0 4785.6 4804.8 4697.0 4729.7 4743.8 4756.5 4775.6 4251.2 4302.8 4314.7 4325.9 4348.5 5982.2 6002.6 6020.0 6040.6 6071.3 5654.5 5700.7 5715.6 5729.9 5792.9 6458.3 6508.3 6531.4 6557.0 6594.9 4866.1 4905.5 4912.1 4928.1 4938.8 6801.5 6828.2 6864.4 6955.0 6994.4 5081.6 5083.5 5097.6 5122.7 5129.4 5094.3 5094.8 5128.9 5151.3 5220.8 5673.1 5678.9 5692.6 5777.8 5788.3 6539.5 6542.9 6549.9 6596.1 6672.1 1766.3 1780.7 1787.6 1787.9 1797.2 1141.3 1153.5 1234.6 1242.3 1253.4 6008.1 6075.3 6162.3 6188.2 6264.3 6719.8 6767.9 6815.1 6832.9 6836.7 6215.2 6224.3 6245.5 6254.5 6347.8 3555.7 3563.2 3569.5 3603.8 3615.5 6960.9 7004.3 7066.6 7071.7 7106.3 6887.5 6929.7 6979.7 6988.4 7029.9 6998.1 7081.4 7089.4 7099.9 7119.4 6705.5 6777.2 6802.9 6861.4 6884.5 6671.6 6707.0 6734.4 6760.9 6788.6 6766.5 6823.7 6905.3 6926.9 7052.6 5057.9 5071.3 5072.3 5082.6 5083.6 6859.0 6878.2 6905.9 6913.9 6928.0 6609.3 6628.3 6636.0 6638.5 6662.4 6649.7 6653.8 6658.6 6662.2 6684.4 6236.7 6502.7 6611.9 6649.1 6650.3 6049.0 6360.3 6466.6 6514.3 6585.1 6377.5 6388.7 6442.4 6460.3 6472.8 17:54:30 INFO - PID 15775 | 17:54:30 INFO - PID 15775 | [#5] yui.html Cycles:180 Average:24699.70 Median:16702.33 stddev:35510.95 (212.6%) stddev-sans-first:35565.71 17:54:30 INFO - PID 15775 | Values: 927.4 945.2 957.4 961.9 965.2 18604.4 21058.8 21756.0 22528.8 22583.0 20573.0 20687.3 21359.1 21386.8 21566.4 1061.3 1073.1 1074.2 1077.5 1077.9 1027.6 1029.9 1031.6 1036.1 1036.8 1075.2 1134.3 1137.7 1138.0 1138.5 842.4 847.8 856.7 858.9 1067.9 804.6 812.0 812.3 814.0 814.2 18232.8 18280.2 18410.7 18477.8 18498.1 21032.8 21209.7 21530.0 21552.7 21603.5 16033.8 16453.8 16462.3 16519.8 16659.8 3691.0 3691.3 3701.8 3717.1 3722.5 137614.0 138439.0 138824.3 141987.4 144413.0 15783.4 16265.2 16483.9 16524.8 16923.0 30210.1 30941.8 32062.2 32263.2 32775.0 8878.2 9112.6 9186.6 9216.3 9218.6 4197.5 4221.3 4235.6 4255.4 4275.7 5475.4 5603.0 5616.1 5622.2 5641.6 1127.2 1130.9 1134.5 1145.1 1147.8 696.5 698.0 705.8 721.8 735.0 12282.4 12670.0 12893.9 13235.4 13348.3 714.0 717.3 718.4 720.2 745.4 5704.2 5923.0 5971.8 5993.3 6014.1 117822.0 122158.4 122443.0 123987.4 125050.0 106097.5 108099.5 108569.0 109183.0 109610.0 93150.5 95019.1 98813.5 100240.0 101794.5 11670.2 11706.1 11714.6 11776.2 11858.6 46481.3 46632.5 46652.8 47573.0 49077.3 57936.7 58108.0 60713.0 61331.7 61539.4 16301.7 16400.0 16605.8 16615.1 16744.9 14987.6 15325.2 15344.8 15392.5 15411.8 15969.6 16026.0 16092.2 16099.7 16164.8 15671.9 15707.6 15807.2 15980.1 16032.8 14746.9 15746.3 15876.2 15989.3 16006.3 10264.2 10685.9 10810.8 10824.5 12566.8 14463.1 14475.6 14540.4 14561.4 14714.8 17:54:30 INFO - PID 15775 | -------- Summary: end -------- 17:54:30 INFO - PID 15775 | 17:54:31 INFO - TEST-INFO | 15775: exit 0 17:54:31 INFO - TEST-OK | dromaeo_css | took 1109506ms 17:54:31 INFO - TEST-START | kraken 17:54:31 INFO - Initialising browser for kraken test... 17:54:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58464/getInfo.html -profile /tmp/tmpzYT18R/profile 17:54:31 INFO - TEST-INFO | started process 16174 (/builds/slave/test/build/application/firefox/firefox http://localhost:58464/getInfo.html) 17:54:36 INFO - TEST-INFO | 16174: exit 0 17:54:36 INFO - Browser initialized. 17:54:36 INFO - Running cycle 1/1 for kraken test... 17:54:36 INFO - TEST-INFO | started process 16423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYT18R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:48 INFO - PID 16423 | RSS: Main: 165953536 17:54:48 INFO - PID 16423 | 17:54:50 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58464/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:51 INFO - PID 16423 | RSS: Main: 169713664 17:54:51 INFO - PID 16423 | 17:54:53 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58464/tests/kraken/driver.html?testName=audio-dft) 17:54:54 INFO - PID 16423 | RSS: Main: 170770432 17:54:54 INFO - PID 16423 | 17:54:57 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58464/tests/kraken/driver.html?testName=audio-fft) 17:54:58 INFO - PID 16423 | RSS: Main: 164450304 17:54:58 INFO - PID 16423 | 17:55:00 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58464/tests/kraken/driver.html?testName=audio-oscillator) 17:55:00 INFO - PID 16423 | RSS: Main: 165928960 17:55:00 INFO - PID 16423 | 17:55:02 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58464/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:55:03 INFO - PID 16423 | RSS: Main: 165523456 17:55:03 INFO - PID 16423 | 17:55:06 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58464/tests/kraken/driver.html?testName=imaging-darkroom) 17:55:06 INFO - PID 16423 | RSS: Main: 165523456 17:55:06 INFO - PID 16423 | 17:55:10 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58464/tests/kraken/driver.html?testName=imaging-desaturate) 17:55:10 INFO - PID 16423 | RSS: Main: 168787968 17:55:10 INFO - PID 16423 | 17:55:13 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58464/tests/kraken/driver.html?testName=json-parse-financial) 17:55:14 INFO - PID 16423 | RSS: Main: 168894464 17:55:14 INFO - PID 16423 | 17:55:15 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58464/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:55:16 INFO - PID 16423 | RSS: Main: 168476672 17:55:16 INFO - PID 16423 | 17:55:17 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:55:18 INFO - PID 16423 | RSS: Main: 168448000 17:55:18 INFO - PID 16423 | 17:55:20 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:55:21 INFO - PID 16423 | RSS: Main: 168710144 17:55:21 INFO - PID 16423 | 17:55:23 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:24 INFO - PID 16423 | RSS: Main: 168464384 17:55:24 INFO - PID 16423 | 17:55:27 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:27 INFO - PID 16423 | RSS: Main: 168910848 17:55:27 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | Cycle 1(1): loaded http://localhost:58464/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58464/tests/kraken/driver.html?testName=ai-astar) 17:55:29 INFO - PID 16423 | RSS: Main: 170991616 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | __start_tp_report 17:55:29 INFO - PID 16423 | _x_x_mozilla_page_load 17:55:29 INFO - PID 16423 | _x_x_mozilla_page_load_details 17:55:29 INFO - PID 16423 | |i|pagename|runs| 17:55:29 INFO - PID 16423 | |0;ai-astar;106;108;94;107;108;108;109;108;106;106 17:55:29 INFO - PID 16423 | |1;audio-beat-detection;149;117;145;168;112;152;141;115;173;114 17:55:29 INFO - PID 16423 | |2;audio-dft;163;164;162;163;162;169;163;162;163;163 17:55:29 INFO - PID 16423 | |3;audio-fft;75;75;76;159;75;73;72;75;100;75 17:55:29 INFO - PID 16423 | |4;audio-oscillator;79;80;124;80;80;80;130;80;81;130 17:55:29 INFO - PID 16423 | |5;imaging-gaussian-blur;114;114;113;113;114;115;114;114;116;113 17:55:29 INFO - PID 16423 | |6;imaging-darkroom;149;147;150;147;155;147;149;149;147;148 17:55:29 INFO - PID 16423 | |7;imaging-desaturate;93;93;94;95;94;94;94;93;94;94 17:55:29 INFO - PID 16423 | |8;json-parse-financial;48;48;46;48;46;49;49;53;50;49 17:55:29 INFO - PID 16423 | |9;json-stringify-tinderbox;53;53;54;55;54;54;54;55;54;53 17:55:29 INFO - PID 16423 | |10;stanford-crypto-aes;75;75;85;76;77;81;74;75;73;76 17:55:29 INFO - PID 16423 | |11;stanford-crypto-ccm;121;121;121;121;134;116;121;121;122;158 17:55:29 INFO - PID 16423 | |12;stanford-crypto-pbkdf2;169;180;181;168;171;171;177;177;168;181 17:55:29 INFO - PID 16423 | |13;stanford-crypto-sha256-iterative;65;63;63;69;66;61;63;61;62;61 17:55:29 INFO - PID 16423 | __end_tp_report 17:55:29 INFO - PID 16423 | __start_cc_report 17:55:29 INFO - PID 16423 | _x_x_mozilla_cycle_collect,874 17:55:29 INFO - PID 16423 | __end_cc_report 17:55:29 INFO - PID 16423 | __startTimestamp1500425729853__endTimestamp 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | ------- Summary: start ------- 17:55:29 INFO - PID 16423 | Number of tests: 14 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#0] ai-astar Cycles:10 Average:106.00 Median:108.00 stddev:4.35 (4.0%) stddev-sans-first:4.61 17:55:29 INFO - PID 16423 | Values: 106.0 108.0 94.0 107.0 108.0 108.0 109.0 108.0 106.0 106.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:147.00 stddev:22.90 (15.6%) stddev-sans-first:23.97 17:55:29 INFO - PID 16423 | Values: 149.0 117.0 145.0 168.0 112.0 152.0 141.0 115.0 173.0 114.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.07 (1.3%) stddev-sans-first:2.19 17:55:29 INFO - PID 16423 | Values: 163.0 164.0 162.0 163.0 162.0 169.0 163.0 162.0 163.0 163.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#3] audio-fft Cycles:10 Average:85.50 Median:75.00 stddev:27.06 (36.1%) stddev-sans-first:28.44 17:55:29 INFO - PID 16423 | Values: 75.0 75.0 76.0 159.0 75.0 73.0 72.0 75.0 100.0 75.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:80.00 stddev:23.25 (29.1%) stddev-sans-first:23.98 17:55:29 INFO - PID 16423 | Values: 79.0 80.0 124.0 80.0 80.0 80.0 130.0 80.0 81.0 130.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 17:55:29 INFO - PID 16423 | Values: 114.0 114.0 113.0 113.0 114.0 115.0 114.0 114.0 116.0 113.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:2.44 (1.6%) stddev-sans-first:2.59 17:55:29 INFO - PID 16423 | Values: 149.0 147.0 150.0 147.0 155.0 147.0 149.0 149.0 147.0 148.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:55:29 INFO - PID 16423 | Values: 93.0 93.0 94.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:49.00 stddev:2.01 (4.1%) stddev-sans-first:2.12 17:55:29 INFO - PID 16423 | Values: 48.0 48.0 46.0 48.0 46.0 49.0 49.0 53.0 50.0 49.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 17:55:29 INFO - PID 16423 | Values: 53.0 53.0 54.0 55.0 54.0 54.0 54.0 55.0 54.0 53.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:3.62 (4.8%) stddev-sans-first:3.79 17:55:29 INFO - PID 16423 | Values: 75.0 75.0 85.0 76.0 77.0 81.0 74.0 75.0 73.0 76.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:121.00 stddev:12.26 (10.1%) stddev-sans-first:12.89 17:55:29 INFO - PID 16423 | Values: 121.0 121.0 121.0 121.0 134.0 116.0 121.0 121.0 122.0 158.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:177.00 stddev:5.44 (3.1%) stddev-sans-first:5.42 17:55:29 INFO - PID 16423 | Values: 169.0 180.0 181.0 168.0 171.0 171.0 177.0 177.0 168.0 181.0 17:55:29 INFO - PID 16423 | 17:55:29 INFO - PID 16423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.59 (4.1%) stddev-sans-first:2.68 17:55:29 INFO - PID 16423 | Values: 65.0 63.0 63.0 69.0 66.0 61.0 63.0 61.0 62.0 61.0 17:55:29 INFO - PID 16423 | -------- Summary: end -------- 17:55:29 INFO - PID 16423 | 17:55:30 INFO - PID 16423 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:55:30 INFO - TEST-INFO | 16423: exit 0 17:55:30 INFO - TEST-OK | kraken | took 59254ms 17:55:30 INFO - SUITE-END | took 1168s 17:55:31 INFO - Completed test suite (00:19:29) 17:55:31 INFO - javascript benchmark 17:55:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8763.833891619379, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3354.2955979244357, 3373.527706121142, 3410.164509695125, 3414.624391316955, 3437.4500079987192, 6250.437460628543, 6271.310155882855, 6288.0, 6327.46216571592, 6450.838729031777, 6402.583832050914, 6451.870962580757, 6465.9676701616545, 6492.480601551876, 6502.089707440962, 5560.748831512918, 5570.913671833994, 5629.408912064236, 5643.351014633308, 5654.349749778767, 5461.044317244487, 5495.807646732365, 5542.501174894259, 5572.721363931808, 5577.470140336662, 5528.391876893558, 5533.6956467394275, 5538.667679939196, 5545.223668686407, 5547.805826796083, 5525.0, 5529.142982837667, 5543.916841247385, 5545.334559852803, 5552.5280351170195, 5466.617336786427, 5519.420460851593, 5529.612927095105, 5530.170474428827, 5533.114701647757, 6226.657533835637, 6230.408111229426, 6250.749970001195, 6252.249730032425, 6258.217722784606, 6789.864202715968, 6812.352826481526, 6822.692978815965, 6822.897656535156, 6843.62360070196, 6907.792766217021, 6909.412699920513, 6911.7926462206215, 6916.896246556305, 6925.722971081151, 6313.053042043684, 6374.776882809079, 6429.7749578764515, 6453.193350831146, 6499.837504062389, 7040.401565866856, 7053.753118640823, 7116.964415177943, 7131.71473141079, 7139.214686384494, 6628.701708423133, 6742.42689371409, 6755.054292399068, 6759.662016899136, 6765.695543700545, 6837.658117094125, 6840.897386539206, 6843.452523798084, 6844.041834143224, 6855.588664680035, 6661.866762664719, 6808.863822723617, 6834.2140653825445, 6874.896876546856, 6888.621125838027, 6893.655317234118, 6913.792586222421, 6925.58446493212, 6996.580205187705, 7007.824804379829, 5079.6952182869145, 5148.099082660594, 5181.248718935733, 5200.6879587224885, 5202.4277329493725, 4498.932516012197, 4515.525869783691, 4519.615832654261, 4527.886802829889, 4544.7045942013665, 5505.421930697299, 6343.460805831556, 6384.712687928962, 6403.743850246031, 6504.642244676588, 6926.030355750199, 6933.237343892168, 6999.335063168991, 7018.438524917994, 7035.437165026786, 6420.807375778734, 6428.325025872309, 6460.224773027173, 6482.124913136666, 6498.805035848932, 5661.0, 5741.885162296814, 5750.079987202028, 5750.913736293959, 5832.912506312408, 7117.3594376505325, 7152.499325047197, 7153.213146553875, 7155.463340249398, 7160.427165826825, 6845.5550389223545, 6927.272636373108, 6937.826554336182, 6940.1671799382375, 6949.2008419030435, 6237.106312749263, 7094.6097964612445, 7154.034205382207, 7156.463265255231, 7159.463040272105, 6844.965775171092, 6848.794536163923, 6896.0, 6914.723411063501, 6919.37725604698, 6944.861102778017, 6971.198312194163, 7002.579845209304, 7038.366547010589, 7077.363037326665, 6603.570767900071, 6666.433353165035, 6678.265390807104, 6694.966525167343, 6752.358525940028, 6678.198616166092, 6685.0, 6708.161479815023, 6708.19501659804, 6722.05891175226, 5657.943420565742, 6665.566738162198, 6733.42765864907, 6774.254831968578, 6787.389134977679, 6624.8012559623285, 6685.39831415175, 6714.0600315954825, 6750.122484077038, 6765.2896445872475, 6493.350664933469, 6523.967380163069, 6526.988316810902, 6531.11829902957, 6536.150300460909], "value": 6235.538469878623, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.5863605811953, 882.1743983394363, 924.4129977464311, 942.8632848237006, 943.2359788571262, 41379.379309310345, 41779.16441671165, 41781.7910910445, 41896.37155442671, 42128.789356053254, 40026.7998660007, 40225.0, 40426.595734042654, 40442.39336409956, 40589.797051014706, 6707.8658426831435, 6773.72905083796, 6795.592264464123, 6803.387695107439, 6836.692348844289, 6656.301088385722, 6732.25945146036, 6734.292899245582, 6735.292794256581, 6736.494762892778, 6695.799126026227, 6702.865942681144, 6705.061291419205, 6726.293739157391, 6753.223379311368, 6683.866322673543, 6689.264180940093, 6703.564268322568, 6711.832204194885, 6734.629595372253, 6138.7237574309265, 6165.075238714184, 6194.4425001749605, 6209.844753881144, 6228.564000519966, 34795.30409391798, 34859.0, 35070.0, 35091.29817403663, 35153.64846351555, 3273.1980664737293, 3293.324868401996, 3319.9170020749434, 3382.3573521030926, 3480.3561341151967, 31663.683363166303, 31947.361052779048, 32001.359972800412, 32044.19889502781, 32096.35807283841, 4982.725950072744, 4989.126902791997, 5023.020511000356, 5030.597552195815, 5086.389633243997, 200695.0, 202987.0, 203178.0, 206288.0, 207265.0, 51997.48002520002, 52675.736621316646, 52925.735371322895, 52961.735191323794, 53113.2033019505, 55677.44322556723, 56153.71923140358, 56183.43816561864, 56258.43741562614, 56297.0, 17004.234809433605, 17263.913680431517, 17278.568035799206, 17281.222344994505, 17282.913585432245, 14136.575902722934, 14146.0, 14228.857711422961, 14233.074850134708, 14240.287985600886, 15093.698126037418, 15161.469348572748, 15213.239338033054, 15355.309011094527, 15442.613934651723, 5862.501687356537, 5929.347771745104, 5999.550033747487, 6003.759849606055, 6110.358412366726, 1061.8141825180562, 1084.5770149641646, 1095.3427943233996, 1095.4960718069617, 1117.8155604325357, 24923.875380623344, 24941.62587561188, 25128.497430051295, 25187.99248030058, 25387.492250154894, 1166.0904494494307, 1178.134071457478, 1192.2488832035763, 1202.5730865542782, 1213.4418167642982, 13296.0, 13327.73344533104, 13417.329133543284, 13431.731365372638, 13463.596092117252, 243584.0, 244864.0, 244958.0, 247326.0, 247351.0, 52167.0, 52428.47571524312, 52467.73766131145, 52548.21177682338, 52743.736281319114, 1479.0829685594786, 1553.223388305847, 1555.440041585006, 1556.533040087969, 1562.5390509799636, 24838.875805620857, 28972.565411518422, 29567.0, 29808.956686515867, 30119.54820677648, 54897.45102548923, 55087.44912550823, 55288.44711552994, 55328.0, 55409.44590554043, 219174.0, 221319.0, 221480.0, 222524.0, 222532.0, 33609.0, 34067.65932340645, 34135.0, 34277.828610856785, 37371.0, 40439.797801010805, 40770.0, 44655.776721116184, 45753.54246457493, 45827.0, 32317.838410807795, 33681.494777578846, 33868.49197262093, 34233.14417139492, 34432.0, 33259.334813304085, 33705.49441758425, 33790.49314260239, 34137.658623413445, 34158.0, 39545.80227098846, 39674.80162599284, 42977.14045719131, 43071.35392969046, 43177.7841110805, 32555.674443255266, 33503.49744753782, 34091.0, 34562.135946601535, 34805.0, 24570.50858982846, 25836.483270334113, 25968.961241550125, 25987.740122599287, 26302.34244143835], "value": 17748.591069520953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4646908671305, 567.1577707104951, 571.5113577890903, 589.7022003888037, 592.7391947543082, 22290.88854555727, 23323.766762332394, 23416.882915585396, 23618.0, 23628.291151265446, 25432.491350172986, 26611.467770644576, 27641.30896727583, 27775.861120694368, 27900.720992790117, 6250.937490625092, 6367.172267605205, 6399.8400039998905, 6400.743970241185, 6414.230292364923, 6289.465395441393, 6302.243730752293, 6324.557280990332, 6339.302676705582, 6339.904901426482, 6003.979323515013, 6095.329513753483, 6260.935640941051, 6270.905936410934, 6287.276963149227, 6219.253689557259, 6256.655883926383, 6300.747970081215, 6307.936920630781, 6316.273628532732, 5777.248957635523, 5781.075027995501, 5806.390329015435, 5844.795432159854, 5871.442212989759, 28553.57169642457, 30207.244818879484, 30478.39043219123, 30539.69460305413, 30582.0, 2168.4578855286177, 2220.9555808883733, 2227.4431392151964, 2243.674667173267, 2247.1123906057014, 19552.413427597196, 20200.393988180378, 20202.09090590927, 20204.0, 20248.291309804234, 2246.8539544929527, 2286.8056215221727, 2324.0, 2325.744168141503, 2331.6735657008035, 152161.0, 158777.20611396868, 159141.0, 160625.0, 160693.19653401658, 15081.321340539702, 15649.0, 15902.568768810863, 15957.563819256091, 16349.754753678704, 24428.26715198547, 24442.51114977726, 24534.141305054236, 24551.50896982086, 24599.38501537476, 10697.83953240702, 10704.78590428187, 10873.782524349468, 10887.782244355069, 10993.395363254938, 9877.40735555869, 9918.950405247928, 9997.950010250048, 10009.698739163861, 10075.143612792996, 9613.51932403391, 9624.342749755187, 9667.178289845302, 9757.170640495495, 10072.899271007196, 2678.9460015582254, 2727.399972006195, 2758.4896794093156, 2827.5334569795755, 2889.197478445904, 1027.3219675014454, 1034.1726618705156, 1036.3781730961364, 1059.655611926127, 1063.9255252132432, 21262.043208055675, 21322.573548528944, 21618.02718877623, 22032.669509957363, 22233.666495002588, 1104.7072525780675, 1107.02028704597, 1111.7220694826294, 1132.422464543089, 1138.1975707126455, 11905.404729763477, 11909.88090119105, 11912.88087119135, 12073.758524829454, 12088.395580220953, 572878.0, 577199.0, 593127.0, 598914.0, 601485.0, 131766.34116829548, 133084.3345783265, 134391.3280433611, 134676.3266183663, 134934.0, 1246.6883279180206, 1264.2035517624022, 1265.4432049898016, 1292.1730092740654, 1292.8254685617321, 18115.72826407631, 19154.329598463988, 19393.612127757082, 19485.0, 19785.10967006517, 61433.38566614276, 62692.05961910484, 63043.6847815758, 63236.683816580626, 63409.0, 82677.17322826936, 85661.57169214114, 85694.14305856862, 85957.57021214854, 86863.56568217119, 14678.77981830252, 15246.390144394543, 15389.461368852037, 15478.845211547741, 15657.921710391374, 22825.771742282366, 23096.0, 23549.29352119439, 24963.375915602257, 25911.093111741, 17602.295908164044, 18683.439496815117, 18806.153723082767, 19023.239070437026, 19126.7130993038, 16612.335506580086, 17105.0, 17132.743008855126, 17437.47687569375, 17955.281788728305, 18626.534336641693, 18660.160292787128, 18706.409955153966, 18737.063146842876, 18914.243430263185, 14373.496927607901, 15176.620584485476, 15245.313960872008, 15303.923480382527, 15357.923210383877, 17558.82441175623, 17708.822911771233, 17733.20200591002, 17754.0, 17808.46574602764], "value": 12534.660564030299, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.289355322339, 1510.4486862295262, 1516.5374560758978, 1525.8016457860476, 1535.9385624575025, 14286.571402857919, 14917.627059323522, 14934.775978360334, 14935.253237338144, 14990.475333363334, 15248.161351125684, 15795.210239488037, 16306.429274975379, 16415.17924103796, 16507.58731031725, 2751.17464760572, 2822.760065394444, 2823.2095013396283, 2827.2083816531403, 2831.5327970884778, 2748.6564179477564, 2775.098093119734, 2777.847218402987, 2778.1804367711475, 2778.610994460777, 2653.9516890828113, 2696.5415879300467, 2725.6320396746482, 2730.7269273072734, 2735.5212837753315, 2613.098481024044, 2711.1324376199623, 2717.4836781011645, 2720.6055122007197, 2722.1153125234378, 2742.9725702742917, 2776.3891943772337, 2777.125205560262, 2783.958240626392, 2789.734975177355, 15570.844291557052, 15627.296771645304, 15658.0, 15662.921685391613, 15699.293531791096, 8364.163583641648, 8707.956460217658, 8729.476231426072, 8732.43239189457, 8733.912660873437, 4867.245576935581, 5060.46865079165, 5180.715060671661, 5202.375714914235, 5226.81706140287, 1840.4264353977424, 1851.278001579385, 1869.9439016829517, 1924.7209154672635, 1937.2154277517627, 26854.25447345916, 26925.596116058077, 26944.05695800657, 26997.595036074476, 27027.189184324503, 7029.718811247493, 7098.964505177544, 7151.427885769126, 7190.64046797658, 7210.062691850026, 17800.643987120184, 17939.641207176046, 17945.282188712306, 17966.730499042525, 18034.2786288547, 8247.381446391544, 8395.62219700115, 8440.62017209227, 8447.070822209553, 8475.915240847513, 7719.11230208522, 7763.262490063548, 7804.3366313862825, 7815.843683126419, 7827.726029588937, 5353.892922141613, 5491.780328786884, 5564.248826408464, 5604.187392828098, 5619.634723742944, 1577.9921100394424, 1591.1248813152952, 1618.5063555615416, 1619.9757003644954, 1631.0, 951.8048799995984, 952.7760976170595, 964.6382606522554, 974.4786539201493, 982.916452101565, 8935.865962010575, 8979.102089791098, 9011.774705632411, 9070.682526111554, 9081.636734530544, 1003.2525768302661, 1011.7824667696481, 1040.5005597313182, 1045.2996492350144, 1061.6443491430302, 5569.582281328917, 5625.296837895263, 5702.315722113373, 5808.5933984621515, 5895.233619629506, 21242.0, 21853.67219491709, 21976.0, 21985.450363741034, 23312.7668723314, 20265.594688106452, 21118.683219751714, 21148.682769758467, 21225.36323910285, 21364.465888352606, 10852.728681783019, 11771.823422648667, 11898.464569094585, 11905.880941190477, 11914.821277680841, 8683.348748843988, 8800.823983520422, 8835.072317406837, 8932.374733768575, 9025.638974441212, 18798.906005469886, 19702.0, 20040.298589549297, 20058.097385617973, 20246.0, 19300.22799088077, 19811.900940495205, 20499.4875128123, 20601.48496287605, 20827.271045513335, 11964.64106076819, 12284.754304914031, 12291.631251062483, 12314.261144331369, 12344.4444999977, 14790.704185916436, 14793.92603036978, 14805.925970370079, 14850.925745371203, 14938.551843444715, 11787.11596630239, 11992.220505667452, 12008.579699710468, 12071.336076515525, 12506.249625022529, 10804.837927431252, 10950.288231264942, 11048.668539943814, 11065.944670276596, 11291.943540282246, 10361.222908281758, 10370.585176592851, 10431.426271555138, 10486.056254937092, 10488.580456781643, 7447.878793915764, 7478.813029674084, 7547.358474529727, 7566.924330756622, 7766.844663106819, 7965.920340796518, 8056.033276006682, 8112.472689275178, 8165.037351976753, 8282.1303763104], "value": 6968.368248342929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.5953277844946, 512.915368964121, 534.2520471340123, 538.281394338558, 542.0514100324432, 6219.689015549216, 6226.719797609107, 6243.157173781538, 6271.717772700228, 6281.748730050793, 5988.550858685605, 5989.610675306102, 6184.9690751546295, 6213.844653883655, 6215.782447614334, 4730.787114579835, 4791.377120974268, 4794.736289504076, 4805.855824325267, 4820.662553621248, 4767.785449654774, 4803.663743537936, 4856.878578035542, 4861.270809378604, 4878.0731660984475, 4540.0, 4755.763501489603, 4774.952250477486, 4785.593224575915, 4804.83183088592, 4696.95303046972, 4729.692569982957, 4743.810247590092, 4756.500567440438, 4775.641826862964, 4251.2347777400055, 4302.827886884521, 4314.676399270036, 4325.935110973338, 4348.543402942709, 5982.162497250389, 6002.609830361012, 6020.0, 6040.637561746309, 6071.2714474263375, 5654.519365853907, 5700.743466543974, 5715.571332150105, 5729.914051289234, 5792.855178620526, 6458.257300410466, 6508.349165083501, 6531.4448271896945, 6556.967215163942, 6594.86810263792, 4866.099771542276, 4905.460399356068, 4912.091263116335, 4928.127311621561, 4938.777755000998, 6801.523893327469, 6828.180618325783, 6864.425840309884, 6954.965225173842, 6994.370506654425, 5081.59347252219, 5083.491650834887, 5097.643164978416, 5122.667026643257, 5129.410117836422, 5094.286799848024, 5094.821681241138, 5128.9230661540105, 5151.304573882553, 5220.755075317574, 5673.121115840374, 5678.943210567924, 5692.6299790513485, 5777.7977770777825, 5788.27646544182, 6539.542232043711, 6542.934570654328, 6549.901751473732, 6596.076549283104, 6672.065101120621, 1766.2758269109604, 1780.7328900664745, 1787.6245988342594, 1787.883787553805, 1797.200245890566, 1141.2923987127867, 1153.5212886652114, 1234.5864135514523, 1242.27327013698, 1253.4296894912793, 6008.098785182257, 6075.33171351151, 6162.291336496271, 6188.195534580565, 6264.310925798159, 6719.798406047827, 6767.864642707118, 6815.148106486689, 6832.93167068323, 6836.726530938806, 6215.223097112861, 6224.253089629183, 6245.531585131042, 6254.498200719658, 6347.841303967438, 3555.6977656898935, 3563.1804684922613, 3569.5002699622073, 3603.819809009539, 3615.4757560154158, 6960.886258198664, 7004.2645522220455, 7066.611336376446, 7071.727089123904, 7106.289371062956, 6887.5178737488895, 6929.688164032631, 6979.708753880548, 6988.44092472601, 7029.859402811915, 6998.145491444873, 7081.388491869184, 7089.397401220954, 7099.858002839915, 7119.430445564342, 6705.463562914858, 6777.220619628806, 6802.897956530557, 6861.387573920025, 6884.5180837342905, 6671.633060181736, 6706.966465167643, 6734.427573656294, 6760.864782704417, 6788.592684438752, 6766.515244648911, 6823.727050917908, 6905.309469053054, 6926.896096558455, 7052.576845389293, 5057.8735531612, 5071.340725705634, 5072.26097907126, 5082.593392528663, 5083.593312535062, 6859.0, 6878.174619045746, 6905.896411553931, 6913.861722765617, 6927.965360173167, 6609.339066093352, 6628.304028076983, 6636.0, 6638.47315117516, 6662.433693136138, 6649.700763465559, 6653.800385988428, 6658.600483970784, 6662.234507855519, 6684.364985326386, 6236.723595887378, 6502.707378168088, 6611.867762644816, 6649.135612370361, 6650.301718319507, 6049.0, 6360.300366959538, 6466.612003279818, 6514.250861150838, 6585.143931289093, 6377.4579160771855, 6388.744450221939, 6442.423030787535, 6460.25707043696, 6472.770173666988], "value": 5105.890842019349, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.4435338796718, 945.2135463973092, 957.3681370295602, 961.8509131084684, 965.165132160681, 18604.441866744004, 21058.789412105893, 21756.0, 22528.77471225287, 22583.0, 20573.0, 20687.275945341917, 21359.145634174616, 21386.786132138674, 21566.353009409704, 1061.3207547169836, 1073.0557109743415, 1074.1621535202555, 1077.49357801833, 1077.9083777878889, 1027.6403258859414, 1029.8558201851747, 1031.566741968375, 1036.0882423467338, 1036.7874585709949, 1075.1989767623093, 1134.279732369947, 1137.7212582917198, 1138.049728476723, 1138.464921486904, 842.4145219072716, 847.817719190377, 856.6573370651727, 858.8625819868822, 1067.9466026698633, 804.6178065418937, 811.9837603247902, 812.3420029775841, 814.0109766633509, 814.242754238558, 18232.817671823246, 18280.17739201739, 18410.723839142425, 18477.815221847744, 18498.075096245135, 21032.789672103238, 21209.681854772192, 21530.0, 21552.676709849366, 21603.45991350213, 16033.839661603351, 16453.753193702105, 16462.259198335985, 16519.83480165195, 16659.750103748454, 3690.9815450922843, 3691.261747650454, 3701.8149092545264, 3717.0893131183034, 3722.4602432647116, 137614.0, 138439.0, 138824.30587847097, 141987.37527998304, 144413.0, 15783.447579334897, 16265.186740662919, 16483.91758041202, 16524.75212871808, 16923.0, 30210.09369718912, 30941.845290773403, 32062.19844503906, 32263.193420164684, 32775.0, 8878.200961913459, 9112.635494580276, 9186.632534698538, 9216.262698984065, 9218.631254749735, 4197.538270790211, 4221.303484925014, 4235.639970602533, 4255.3829694694095, 4275.700700950903, 5475.370332411744, 5602.963451761437, 5616.073347897551, 5622.240997465372, 5641.633293835887, 1127.2391135983178, 1130.8529891114104, 1134.5235001299475, 1145.118258940611, 1147.8048731715628, 696.5472442912046, 697.9895301570481, 705.8200158959432, 721.7798571435658, 735.0224201811578, 12282.385880706108, 12670.0, 12893.871061289266, 13235.404406801717, 13348.265845378402, 713.9857202856018, 717.2791344698545, 718.3678363040491, 720.1969803668871, 745.3515441565872, 5704.201411802351, 5922.970385148046, 5971.820845374646, 5993.250843644544, 6014.127951447016, 117822.0, 122158.38920805338, 122443.0, 123987.3800630991, 125050.0, 106097.46951265194, 108099.45950270198, 108569.0, 109183.0, 109610.0, 93150.53424732969, 95019.12309754653, 98813.50593246988, 100240.0, 101794.49102754291, 11670.183087183816, 11706.1220408468, 11714.589989350332, 11776.234544754563, 11858.584949526725, 46481.30278045764, 46632.533674662816, 46652.7667361661, 47573.0, 49077.2638410417, 57936.71031644983, 58108.0, 60713.0, 61331.693341533006, 61539.38460615516, 16301.67396652084, 16400.0, 16605.75091373606, 16615.086170260267, 16744.916275418545, 14987.625309366917, 15325.157116358707, 15344.846551534789, 15392.538223853302, 15411.845881541489, 15969.600759980629, 16026.0, 16092.195390230676, 16099.67800644004, 16164.757528637316, 15671.921640391725, 15707.607309817346, 15807.209639517749, 15980.121093339978, 16032.759508607147, 14746.926265368604, 15746.291416886039, 15876.206189690238, 15989.280482378554, 16006.279717412977, 10264.230182736474, 10685.893141068489, 10810.837837432287, 10824.458777060958, 12566.811497827723, 14463.13221206731, 14475.565733028026, 14540.41838326455, 14561.41754329815, 14714.779278311047], "value": 9178.7947389956, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 94.0, 107.0, 108.0, 108.0, 109.0, 108.0, 106.0, 106.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 145.0, 168.0, 112.0, 152.0, 141.0, 115.0, 173.0, 114.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 163.0, 162.0, 169.0, 163.0, 162.0, 163.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 159.0, 75.0, 73.0, 72.0, 75.0, 100.0, 75.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 124.0, 80.0, 80.0, 80.0, 130.0, 80.0, 81.0, 130.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 116.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 150.0, 147.0, 155.0, 147.0, 149.0, 149.0, 147.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 46.0, 48.0, 46.0, 49.0, 49.0, 53.0, 50.0, 49.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 85.0, 76.0, 77.0, 81.0, 74.0, 75.0, 73.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 121.0, 121.0, 134.0, 116.0, 121.0, 121.0, 122.0, 158.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 180.0, 181.0, 168.0, 171.0, 171.0, 177.0, 177.0, 168.0, 181.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 69.0, 66.0, 61.0, 63.0, 61.0, 62.0, 61.0], "value": 63.4, "unit": "score"}]}]} 17:55:31 INFO - Return code: 0 17:55:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:31 INFO - # TBPL SUCCESS # 17:55:31 INFO - Running post-action listener: _package_coverage_data 17:55:31 INFO - Running post-action listener: _resource_record_post_action 17:55:31 INFO - [mozharness: 2017-07-19 00:55:31.145553Z] Finished run-tests step (success) 17:55:31 INFO - Running post-run listener: _resource_record_post_run 17:55:31 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 425373696; Read time: 0; Write time: 279216 17:55:31 INFO - TinderboxPrint: CPU usage
13.0% 17:55:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:55:31 INFO - TinderboxPrint: I/O write bytes / time
425,373,696 / 279,216 17:55:31 INFO - TinderboxPrint: CPU idle
8,232.4 (87.0%) 17:55:31 INFO - TinderboxPrint: CPU user
1,187.9 (12.5%) 17:55:31 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107335680; Read time: 0; Write time: 62608 17:55:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:55:31 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 314961920; Read time: 0; Write time: 216284 17:55:31 INFO - Running post-run listener: _upload_blobber_files 17:55:31 INFO - Blob upload gear active. 17:55:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:31 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 17:55:31 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'] 17:55:31 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 17:55:32 INFO - Traceback (most recent call last): 17:55:32 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 17:55:32 INFO - main() 17:55:32 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 17:55:32 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 17:55:32 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 17:55:32 INFO - return set(response.json().get('whitelist', [])) 17:55:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 17:55:32 INFO - return json.loads(self.text or self.content, **kwargs) 17:55:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 17:55:32 INFO - return _default_decoder.decode(s) 17:55:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 17:55:32 INFO - obj, end = self.raw_decode(s) 17:55:32 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 17:55:32 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 17:55:32 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 17:55:32 ERROR - Return code: 1 17:55:32 INFO - Setting buildbot property blobber_files to {} 17:55:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:32 INFO - Contents: 17:55:32 INFO - blobber_files:{} 17:55:32 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:32 INFO - Copying logs to upload dir... 17:55:32 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.282436 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-07-18 17:55:31.364433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 17:55:31.367953) ========= 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=ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/BWHLihj4QTOZAHkuysZsLA/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-18 17:55:31.418731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:55:31.419050) ========= 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=ed14279e38b05397cf4aa391000001a4-1500423937.430088-1061946089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:55:31.468269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 17:55:31.468553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 17:55:31.468853) ========= ========= Total master_lag: 0.92 =========