builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1496710106.94 results: success (0) revision: 3cfe81678881ada0245215c8863bc9722925bb44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:26.942489) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:26.943517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:26.943855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:27.002308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:27.002641) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 17:48:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2017-06-05 17:48:27 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.186050 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:27.227148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:27.227849) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017235 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:27.279288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 17:48:27.279737) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3cfe81678881ada0245215c8863bc9722925bb44 --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 3cfe81678881ada0245215c8863bc9722925bb44 --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=9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 17:48:27,385 truncating revision to first 12 chars 2017-06-05 17:48:27,385 Setting DEBUG logging. 2017-06-05 17:48:27,385 attempt 1/10 2017-06-05 17:48:27,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3cfe81678881?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 17:48:28,577 unpacking tar archive at: mozilla-central-3cfe81678881/testing/mozharness/ program finished with exit code 0 elapsedTime=1.518360 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 17:48:28.816355) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:28.816687) ========= script_repo_revision: 3cfe81678881ada0245215c8863bc9722925bb44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:28.817117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:28.817413) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 17:48:28.833996) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-05 17:48:28.834305) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:48:29 INFO - MultiFileLogger online at 20170605 17:48:29 in /builds/slave/test 17:48:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:48:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:48:29 INFO - {'append_to_log': False, 17:48:29 INFO - 'base_work_dir': '/builds/slave/test', 17:48:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:48:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:48:29 INFO - 'branch': 'Firefox-Non-PGO', 17:48:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:48:29 INFO - 'config_files': ('talos/linux_config.py',), 17:48:29 INFO - 'default_actions': ('clobber', 17:48:29 INFO - 'read-buildbot-config', 17:48:29 INFO - 'download-and-extract', 17:48:29 INFO - 'populate-webroot', 17:48:29 INFO - 'create-virtualenv', 17:48:29 INFO - 'install', 17:48:29 INFO - 'setup-mitmproxy', 17:48:29 INFO - 'run-tests'), 17:48:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:48:29 INFO - 'download_minidump_stackwalk': True, 17:48:29 INFO - 'download_symbols': 'ondemand', 17:48:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:48:29 INFO - 'tooltool.py': '/tools/tooltool.py', 17:48:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:48:29 INFO - '/tools/misc-python/virtualenv.py')}, 17:48:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:48:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:48:29 INFO - 'gecko_profile': False, 17:48:29 INFO - 'gecko_profile_interval': 0, 17:48:29 INFO - 'installer_path': 'installer.exe', 17:48:29 INFO - 'log_level': 'info', 17:48:29 INFO - 'log_name': 'talos', 17:48:29 INFO - 'log_to_console': True, 17:48:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:48:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:48:29 INFO - 'opt_config_files': (), 17:48:29 INFO - 'pip_index': False, 17:48:29 INFO - 'suite': 'dromaeojs-e10s', 17:48:29 INFO - 'system_bits': '32', 17:48:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:48:29 INFO - 'title': 'talos-linux64-ix-040', 17:48:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:48:29 INFO - 'use_talos_json': True, 17:48:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:48:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:48:29 INFO - 'work_dir': 'build'} 17:48:29 INFO - [mozharness: 2017-06-06 00:48:29.178718Z] Running clobber step. 17:48:29 INFO - Running pre-action listener: _resource_record_pre_action 17:48:29 INFO - Running main action method: clobber 17:48:29 INFO - rmtree: /builds/slave/test/build 17:48:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:48:30 INFO - Running post-action listener: _resource_record_post_action 17:48:30 INFO - [mozharness: 2017-06-06 00:48:30.165158Z] Finished clobber step (success) 17:48:30 INFO - [mozharness: 2017-06-06 00:48:30.165260Z] Running read-buildbot-config step. 17:48:30 INFO - Running pre-action listener: _resource_record_pre_action 17:48:30 INFO - Running main action method: read_buildbot_config 17:48:30 INFO - Using buildbot properties: 17:48:30 INFO - { 17:48:30 INFO - "project": "", 17:48:30 INFO - "product": "firefox", 17:48:30 INFO - "who": "ryanvm@gmail.com", 17:48:30 INFO - "installer_path": "public/build/target.tar.bz2", 17:48:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:48:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:48:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:48:30 INFO - "stage_platform": "linux64", 17:48:30 INFO - "basedir": "/builds/slave/test", 17:48:30 INFO - "buildnumber": 937, 17:48:30 INFO - "platform": "ubuntu64_hw", 17:48:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:48:30 INFO - "slavebuilddir": "test", 17:48:30 INFO - "taskId": "WTml1RhaSbqKaTDSdS2m0w", 17:48:30 INFO - "branch": "mozilla-central", 17:48:30 INFO - "script_repo_revision": "production", 17:48:30 INFO - "revision": "3cfe81678881ada0245215c8863bc9722925bb44", 17:48:30 INFO - "slavename": "talos-linux64-ix-040", 17:48:30 INFO - "repo_path": "mozilla-central" 17:48:30 INFO - } 17:48:30 INFO - Finding installer, test and symbols from parent task. 17:48:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WTml1RhaSbqKaTDSdS2m0w'}, attempt #1 17:48:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WTml1RhaSbqKaTDSdS2m0w'}, attempt #1 17:48:31 INFO - Task dependencies: d1UkrHjKRd2sW85l0wKq-Q 17:48:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q'}, attempt #1 17:48:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2 17:48:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/test_packages.json 17:48:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.crashreporter-symbols.zip 17:48:31 INFO - Running post-action listener: _resource_record_post_action 17:48:31 INFO - [mozharness: 2017-06-06 00:48:31.945426Z] Finished read-buildbot-config step (success) 17:48:31 INFO - [mozharness: 2017-06-06 00:48:31.945649Z] Running download-and-extract step. 17:48:31 INFO - Running pre-action listener: _resource_record_pre_action 17:48:31 INFO - Running main action method: download_and_extract 17:48:31 INFO - mkdir: /builds/slave/test/build/tests 17:48: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:48:31 INFO - trying https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.test_packages.json 17:48:31 INFO - Downloading https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:48:32 INFO - Downloaded 989 bytes. 17:48:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:48:32 INFO - Using the following test package requirements: 17:48:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:48:32 INFO - u'common': [u'target.common.tests.zip'], 17:48:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:48:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:48:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:48:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:48:32 INFO - u'mozbase': [u'target.common.tests.zip'], 17:48:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:48:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:48:32 INFO - u'web-platform': [u'target.common.tests.zip', 17:48:32 INFO - u'target.web-platform.tests.tar.gz'], 17:48:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:48:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:48:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.common.tests.zip 17:48:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:48:32 INFO - Fetch https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.common.tests.zip into memory 17:48:35 INFO - Content-Length response header: 65108351 17:48:35 INFO - Bytes received: 65108351 17:48:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:48:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.common.tests.zip 17:48:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:48:46 INFO - Fetch https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.common.tests.zip into memory 17:48:48 INFO - Content-Length response header: 65108351 17:48:48 INFO - Bytes received: 65108351 17:49:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.talos.tests.zip 17:49:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:49:00 INFO - Fetch https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.talos.tests.zip into memory 17:49:01 INFO - Content-Length response header: 14447425 17:49:01 INFO - Bytes received: 14447425 17:49: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:49:01 INFO - trying https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2 17:49:01 INFO - Downloading https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:49:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:49:04 INFO - Downloaded 58803637 bytes. 17:49:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2 17:49:04 INFO - mkdir: /builds/slave/test/properties 17:49:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:49:04 INFO - Writing to file /builds/slave/test/properties/build_url 17:49:04 INFO - Contents: 17:49:04 INFO - build_url:https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2 17:49:04 INFO - Running post-action listener: _resource_record_post_action 17:49:04 INFO - Running post-action listener: set_extra_try_arguments 17:49:04 INFO - [mozharness: 2017-06-06 00:49:04.379411Z] Finished download-and-extract step (success) 17:49:04 INFO - [mozharness: 2017-06-06 00:49:04.379638Z] Running populate-webroot step. 17:49:04 INFO - Running pre-action listener: _resource_record_pre_action 17:49:04 INFO - Running main action method: populate_webroot 17:49:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:49:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:49:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:49:04 INFO - '--tppagecycles', 17:49:04 INFO - '7'], 17:49:04 INFO - 'tests': ['tsvgm']}}, 17:49:04 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:49:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:49:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:49:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:49:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['damp', 'tps']}, 17:49:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'tests': ['damp', 'tps']}, 17:49:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['dromaeo_dom']}, 17:49:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:49:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:49:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:49:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:49:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['a11yr', 17:49:04 INFO - 'ts_paint', 17:49:04 INFO - 'tpaint', 17:49:04 INFO - 'sessionrestore', 17:49:04 INFO - 'sessionrestore_no_auto_restore', 17:49:04 INFO - 'tabpaint']}, 17:49:04 INFO - 'other-e10s': {'tests': ['a11yr', 17:49:04 INFO - 'ts_paint', 17:49:04 INFO - 'tpaint', 17:49:04 INFO - 'sessionrestore', 17:49:04 INFO - 'sessionrestore_no_auto_restore', 17:49:04 INFO - 'tabpaint']}, 17:49:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:49:04 INFO - 'ts_paint', 17:49:04 INFO - 'tpaint', 17:49:04 INFO - 'sessionrestore', 17:49:04 INFO - 'sessionrestore_no_auto_restore', 17:49:04 INFO - 'tabpaint']}, 17:49:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:49:04 INFO - 'ts_paint', 17:49:04 INFO - 'tpaint', 17:49:04 INFO - 'sessionrestore', 17:49:04 INFO - 'sessionrestore_no_auto_restore', 17:49:04 INFO - 'tabpaint']}, 17:49:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['a11yr', 17:49:04 INFO - 'ts_paint', 17:49:04 INFO - 'tpaint', 17:49:04 INFO - 'sessionrestore', 17:49:04 INFO - 'sessionrestore_no_auto_restore', 17:49:04 INFO - 'tabpaint']}, 17:49:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['a11yr', 17:49:04 INFO - 'ts_paint', 17:49:04 INFO - 'tpaint', 17:49:04 INFO - 'sessionrestore', 17:49:04 INFO - 'sessionrestore_no_auto_restore', 17:49:04 INFO - 'tabpaint']}, 17:49:04 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:49:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:49:04 INFO - 'bloom_basic_ref']}, 17:49:04 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 17:49:04 INFO - 'talos_options': ['--mitmproxy', 17:49:04 INFO - 'mitmproxy-recording-1.mp', 17:49:04 INFO - '--firstNonBlankPaint'], 17:49:04 INFO - 'tests': ['Quantum_1']}, 17:49:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['tsvgx', 17:49:04 INFO - 'tsvgr_opacity', 17:49:04 INFO - 'tart', 17:49:04 INFO - 'tscrollx', 17:49:04 INFO - 'cart', 17:49:04 INFO - 'tsvg_static']}, 17:49:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:49:04 INFO - 'tsvgr_opacity', 17:49:04 INFO - 'tart', 17:49:04 INFO - 'tscrollx', 17:49:04 INFO - 'cart', 17:49:04 INFO - 'tsvg_static']}, 17:49:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'talos_options': ['--disable-e10s'], 17:49:04 INFO - 'tests': ['tp5o']}, 17:49:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:49:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'talos_options': ['--disable-e10s', 17:49:04 INFO - '--xperf_path', 17:49:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:04 INFO - 'tests': ['tp5n']}, 17:49:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:49:04 INFO - 'talos_options': ['--xperf_path', 17:49:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:49:04 INFO - 'tests': ['tp5n']}}, 17:49:04 INFO - 'talos.zip': {'path': '', 17:49:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:49:04 INFO - Running post-action listener: _resource_record_post_action 17:49:04 INFO - [mozharness: 2017-06-06 00:49:04.397128Z] Finished populate-webroot step (success) 17:49:04 INFO - [mozharness: 2017-06-06 00:49:04.397224Z] Running create-virtualenv step. 17:49:04 INFO - Running pre-action listener: _resource_record_pre_action 17:49:04 INFO - Running main action method: create_virtualenv 17:49:04 INFO - Creating virtualenv /builds/slave/test/build/venv 17:49:04 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:49:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:49:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:49:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:49:04 INFO - Using real prefix '/usr' 17:49:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:49:05 INFO - Installing distribute.............................................................................................................................................................................................done. 17:49:07 INFO - Installing pip.................done. 17:49:07 INFO - Return code: 0 17:49:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:49:07 INFO - Reading from file tmpfile_stdout 17:49:07 INFO - Output received: 17:49:07 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:49:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:07 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:07 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:49:07 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:49:07 INFO - Using env: {'DISPLAY': ':0', 17:49:07 INFO - 'HOME': '/home/cltbld', 17:49:07 INFO - 'LANG': 'en_US.UTF-8', 17:49:07 INFO - 'LANGUAGE': 'en_US:en', 17:49:07 INFO - 'LOGNAME': 'cltbld', 17:49:07 INFO - 'MAIL': '/var/mail/cltbld', 17:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:07 INFO - 'MOZ_NO_REMOTE': '1', 17:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:07 INFO - 'NO_EM_RESTART': '1', 17:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:07 INFO - 'PWD': '/builds/slave/test', 17:49:07 INFO - 'SHELL': '/bin/bash', 17:49:07 INFO - 'SHLVL': '1', 17:49:07 INFO - 'TERM': 'linux', 17:49:07 INFO - 'TMOUT': '86400', 17:49:07 INFO - 'USER': 'cltbld', 17:49:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:07 INFO - '_': '/tools/buildbot/bin/python'} 17:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:07 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:49:07 INFO - Cleaning up... 17:49:07 INFO - Return code: 0 17:49:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:07 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:07 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:49:07 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:49:07 INFO - Using env: {'DISPLAY': ':0', 17:49:07 INFO - 'HOME': '/home/cltbld', 17:49:07 INFO - 'LANG': 'en_US.UTF-8', 17:49:07 INFO - 'LANGUAGE': 'en_US:en', 17:49:07 INFO - 'LOGNAME': 'cltbld', 17:49:07 INFO - 'MAIL': '/var/mail/cltbld', 17:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:07 INFO - 'MOZ_NO_REMOTE': '1', 17:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:07 INFO - 'NO_EM_RESTART': '1', 17:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:07 INFO - 'PWD': '/builds/slave/test', 17:49:07 INFO - 'SHELL': '/bin/bash', 17:49:07 INFO - 'SHLVL': '1', 17:49:07 INFO - 'TERM': 'linux', 17:49:07 INFO - 'TMOUT': '86400', 17:49:07 INFO - 'USER': 'cltbld', 17:49:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:07 INFO - '_': '/tools/buildbot/bin/python'} 17:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:07 INFO - Downloading/unpacking psutil>=3.1.1 17:49:07 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:49:07 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:49:07 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:49:07 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:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:49:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:09 INFO - Installing collected packages: psutil 17:49:09 INFO - Running setup.py install for psutil 17:49:09 INFO - building 'psutil._psutil_linux' extension 17:49:09 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:49:10 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:49:10 INFO - building 'psutil._psutil_posix' extension 17:49:10 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:49:10 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:49:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:49:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:49:10 INFO - Successfully installed psutil 17:49:10 INFO - Cleaning up... 17:49:10 INFO - Return code: 0 17:49:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:49:10 INFO - Using env: {'DISPLAY': ':0', 17:49:10 INFO - 'HOME': '/home/cltbld', 17:49:10 INFO - 'LANG': 'en_US.UTF-8', 17:49:10 INFO - 'LANGUAGE': 'en_US:en', 17:49:10 INFO - 'LOGNAME': 'cltbld', 17:49:10 INFO - 'MAIL': '/var/mail/cltbld', 17:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:10 INFO - 'MOZ_NO_REMOTE': '1', 17:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:10 INFO - 'NO_EM_RESTART': '1', 17:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:10 INFO - 'PWD': '/builds/slave/test', 17:49:10 INFO - 'SHELL': '/bin/bash', 17:49:10 INFO - 'SHLVL': '1', 17:49:10 INFO - 'TERM': 'linux', 17:49:10 INFO - 'TMOUT': '86400', 17:49:10 INFO - 'USER': 'cltbld', 17:49:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:10 INFO - '_': '/tools/buildbot/bin/python'} 17:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:49:10 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:49:10 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:49:10 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:49:10 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:49:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:49:11 INFO - Installing collected packages: mozsystemmonitor 17:49:12 INFO - Running setup.py install for mozsystemmonitor 17:49:12 INFO - Successfully installed mozsystemmonitor 17:49:12 INFO - Cleaning up... 17:49:12 INFO - Return code: 0 17:49:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:49:12 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:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:12 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:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:12 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:12 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:49:12 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:49:12 INFO - Using env: {'DISPLAY': ':0', 17:49:12 INFO - 'HOME': '/home/cltbld', 17:49:12 INFO - 'LANG': 'en_US.UTF-8', 17:49:12 INFO - 'LANGUAGE': 'en_US:en', 17:49:12 INFO - 'LOGNAME': 'cltbld', 17:49:12 INFO - 'MAIL': '/var/mail/cltbld', 17:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:12 INFO - 'MOZ_NO_REMOTE': '1', 17:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:12 INFO - 'NO_EM_RESTART': '1', 17:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:12 INFO - 'PWD': '/builds/slave/test', 17:49:12 INFO - 'SHELL': '/bin/bash', 17:49:12 INFO - 'SHLVL': '1', 17:49:12 INFO - 'TERM': 'linux', 17:49:12 INFO - 'TMOUT': '86400', 17:49:12 INFO - 'USER': 'cltbld', 17:49:12 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:12 INFO - '_': '/tools/buildbot/bin/python'} 17:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:49:12 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:49:12 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:49:12 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:49:12 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:49:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:49:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:49:13 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:49:13 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:49:13 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:49:13 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:49:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:49:13 INFO - warning: no files found matching '*.txt' 17:49:13 INFO - no previously-included directories found matching 'build' 17:49:13 INFO - no previously-included directories found matching 'dist' 17:49:13 INFO - no previously-included directories found matching '.git*' 17:49:13 INFO - Installing collected packages: jsonschema, functools32 17:49:13 INFO - Running setup.py install for functools32 17:49:13 INFO - warning: no files found matching '*.txt' 17:49:13 INFO - no previously-included directories found matching 'build' 17:49:13 INFO - no previously-included directories found matching 'dist' 17:49:13 INFO - no previously-included directories found matching '.git*' 17:49:13 INFO - Successfully installed jsonschema functools32 17:49:13 INFO - Cleaning up... 17:49:13 INFO - Return code: 0 17:49:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:13 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:13 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:49:13 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:49:13 INFO - Using env: {'DISPLAY': ':0', 17:49:13 INFO - 'HOME': '/home/cltbld', 17:49:13 INFO - 'LANG': 'en_US.UTF-8', 17:49:13 INFO - 'LANGUAGE': 'en_US:en', 17:49:13 INFO - 'LOGNAME': 'cltbld', 17:49:13 INFO - 'MAIL': '/var/mail/cltbld', 17:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:13 INFO - 'MOZ_NO_REMOTE': '1', 17:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:13 INFO - 'NO_EM_RESTART': '1', 17:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:13 INFO - 'PWD': '/builds/slave/test', 17:49:13 INFO - 'SHELL': '/bin/bash', 17:49:13 INFO - 'SHLVL': '1', 17:49:13 INFO - 'TERM': 'linux', 17:49:13 INFO - 'TMOUT': '86400', 17:49:13 INFO - 'USER': 'cltbld', 17:49:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:13 INFO - '_': '/tools/buildbot/bin/python'} 17:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:49:14 INFO - Cleaning up... 17:49:14 INFO - Return code: 0 17:49:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:49:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:49:14 INFO - Using env: {'DISPLAY': ':0', 17:49:14 INFO - 'HOME': '/home/cltbld', 17:49:14 INFO - 'LANG': 'en_US.UTF-8', 17:49:14 INFO - 'LANGUAGE': 'en_US:en', 17:49:14 INFO - 'LOGNAME': 'cltbld', 17:49:14 INFO - 'MAIL': '/var/mail/cltbld', 17:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:14 INFO - 'MOZ_NO_REMOTE': '1', 17:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:14 INFO - 'NO_EM_RESTART': '1', 17:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:14 INFO - 'PWD': '/builds/slave/test', 17:49:14 INFO - 'SHELL': '/bin/bash', 17:49:14 INFO - 'SHLVL': '1', 17:49:14 INFO - 'TERM': 'linux', 17:49:14 INFO - 'TMOUT': '86400', 17:49:14 INFO - 'USER': 'cltbld', 17:49:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:14 INFO - '_': '/tools/buildbot/bin/python'} 17:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:14 INFO - Downloading/unpacking blobuploader==1.2.4 17:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:15 INFO - Downloading blobuploader-1.2.4.tar.gz 17:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:49:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:49:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:49:15 INFO - Downloading docopt-0.6.1.tar.gz 17:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:49:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:49:15 INFO - Running setup.py install for blobuploader 17:49:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:49:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:49:16 INFO - Running setup.py install for requests 17:49:16 INFO - Running setup.py install for docopt 17:49:16 INFO - Successfully installed blobuploader requests docopt 17:49:16 INFO - Cleaning up... 17:49:16 INFO - Return code: 0 17:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:16 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:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:16 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:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:16 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:16 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:49:16 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:49:16 INFO - Using env: {'DISPLAY': ':0', 17:49:16 INFO - 'HOME': '/home/cltbld', 17:49:16 INFO - 'LANG': 'en_US.UTF-8', 17:49:16 INFO - 'LANGUAGE': 'en_US:en', 17:49:16 INFO - 'LOGNAME': 'cltbld', 17:49:16 INFO - 'MAIL': '/var/mail/cltbld', 17:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:16 INFO - 'MOZ_NO_REMOTE': '1', 17:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:16 INFO - 'NO_EM_RESTART': '1', 17:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:16 INFO - 'PWD': '/builds/slave/test', 17:49:16 INFO - 'SHELL': '/bin/bash', 17:49:16 INFO - 'SHLVL': '1', 17:49:16 INFO - 'TERM': 'linux', 17:49:16 INFO - 'TMOUT': '86400', 17:49:16 INFO - 'USER': 'cltbld', 17:49:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:16 INFO - '_': '/tools/buildbot/bin/python'} 17:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:16 INFO - Running setup.py (path:/tmp/pip-RM3jdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:16 INFO - Running setup.py (path:/tmp/pip-lfa3yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:16 INFO - Running setup.py (path:/tmp/pip-mPh6gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:16 INFO - Running setup.py (path:/tmp/pip-6AfGNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:17 INFO - Running setup.py (path:/tmp/pip-IBsHGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:17 INFO - Running setup.py (path:/tmp/pip-PCk6ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:17 INFO - Running setup.py (path:/tmp/pip-UZFouO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:17 INFO - Running setup.py (path:/tmp/pip-pAkgQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:17 INFO - Running setup.py (path:/tmp/pip-KwNDx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:17 INFO - Running setup.py (path:/tmp/pip-WHrlLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:17 INFO - Running setup.py (path:/tmp/pip-EOThLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:17 INFO - Running setup.py (path:/tmp/pip-XjwmaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:17 INFO - Running setup.py (path:/tmp/pip-FFgigI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:17 INFO - Running setup.py (path:/tmp/pip-ipQFOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:17 INFO - Running setup.py (path:/tmp/pip-hu4eJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:17 INFO - Running setup.py (path:/tmp/pip-oPxhkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:17 INFO - Running setup.py (path:/tmp/pip-lHWg_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:49:17 INFO - Running setup.py install for manifestparser 17:49:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Running setup.py install for mozcrash 17:49:18 INFO - Running setup.py install for mozdebug 17:49:18 INFO - Running setup.py install for mozdevice 17:49:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Running setup.py install for mozfile 17:49:18 INFO - Running setup.py install for mozhttpd 17:49:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Running setup.py install for mozinfo 17:49:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Running setup.py install for mozInstall 17:49:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Running setup.py install for mozleak 17:49:18 INFO - Running setup.py install for mozlog 17:49:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:49:18 INFO - Running setup.py install for moznetwork 17:49:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:49:19 INFO - Running setup.py install for mozprocess 17:49:19 INFO - Running setup.py install for mozprofile 17:49:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:49:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:49:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:49:19 INFO - Running setup.py install for mozrunner 17:49:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:49:19 INFO - Running setup.py install for mozscreenshot 17:49:19 INFO - Running setup.py install for moztest 17:49:19 INFO - Running setup.py install for mozversion 17:49:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:49:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:49:19 INFO - Cleaning up... 17:49:19 INFO - Return code: 0 17:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:19 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:19 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:49:19 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:49:19 INFO - Using env: {'DISPLAY': ':0', 17:49:19 INFO - 'HOME': '/home/cltbld', 17:49:19 INFO - 'LANG': 'en_US.UTF-8', 17:49:19 INFO - 'LANGUAGE': 'en_US:en', 17:49:19 INFO - 'LOGNAME': 'cltbld', 17:49:19 INFO - 'MAIL': '/var/mail/cltbld', 17:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:19 INFO - 'MOZ_NO_REMOTE': '1', 17:49:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:19 INFO - 'NO_EM_RESTART': '1', 17:49:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:19 INFO - 'PWD': '/builds/slave/test', 17:49:19 INFO - 'SHELL': '/bin/bash', 17:49:19 INFO - 'SHLVL': '1', 17:49:19 INFO - 'TERM': 'linux', 17:49:19 INFO - 'TMOUT': '86400', 17:49:19 INFO - 'USER': 'cltbld', 17:49:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:19 INFO - '_': '/tools/buildbot/bin/python'} 17:49:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:49:19 INFO - Running setup.py (path:/tmp/pip-FWpRlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:49:20 INFO - Running setup.py (path:/tmp/pip-Wufs9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:49:20 INFO - Running setup.py (path:/tmp/pip-aKill4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:49:20 INFO - Running setup.py (path:/tmp/pip-JQHa6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:49:20 INFO - Running setup.py (path:/tmp/pip-oRN7RP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:49:20 INFO - Running setup.py (path:/tmp/pip-HN3BYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:49:20 INFO - Running setup.py (path:/tmp/pip-TiKJHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:49:20 INFO - Running setup.py (path:/tmp/pip-qpYa2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:49:20 INFO - Running setup.py (path:/tmp/pip-NYDCmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:49:20 INFO - Running setup.py (path:/tmp/pip-MaxqRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:49:20 INFO - Running setup.py (path:/tmp/pip-5VfFLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:49:20 INFO - Running setup.py (path:/tmp/pip-1ILhck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:49:20 INFO - Running setup.py (path:/tmp/pip-UpvqGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:49:20 INFO - Running setup.py (path:/tmp/pip-DLtJaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:49:20 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:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:20 INFO - Running setup.py (path:/tmp/pip-A0aeVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:49:21 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:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:49:21 INFO - Running setup.py (path:/tmp/pip-w9vQH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:49:21 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:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:49:21 INFO - Running setup.py (path:/tmp/pip-HvPpNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:49:21 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:49:21 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:49:21 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:49:21 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:49:21 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:49:21 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:49:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:49:21 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:49:21 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:49:21 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:49:21 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:49:22 INFO - Downloading blessings-1.6.tar.gz 17:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:49:22 INFO - Installing collected packages: blessings 17:49:22 INFO - Running setup.py install for blessings 17:49:22 INFO - Successfully installed blessings 17:49:22 INFO - Cleaning up... 17:49:22 INFO - Return code: 0 17:49:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:49:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:22 INFO - Reading from file tmpfile_stdout 17:49:22 INFO - Current package versions: 17:49:22 INFO - argparse == 1.2.1 17:49:22 INFO - blessings == 1.6 17:49:22 INFO - blobuploader == 1.2.4 17:49:22 INFO - docopt == 0.6.1 17:49:22 INFO - functools32 == 3.2.3-2 17:49:22 INFO - jsonschema == 2.5.1 17:49:22 INFO - manifestparser == 1.1 17:49:22 INFO - mozInstall == 1.12 17:49:22 INFO - mozcrash == 1.0 17:49:22 INFO - mozdebug == 0.1 17:49:22 INFO - mozdevice == 0.51 17:49:22 INFO - mozfile == 1.2 17:49:22 INFO - mozhttpd == 0.7 17:49:22 INFO - mozinfo == 0.10 17:49:22 INFO - mozleak == 0.1 17:49:22 INFO - mozlog == 3.4 17:49:22 INFO - moznetwork == 0.27 17:49:22 INFO - mozprocess == 0.25 17:49:22 INFO - mozprofile == 0.28 17:49:22 INFO - mozrunner == 6.13 17:49:22 INFO - mozscreenshot == 0.1 17:49:22 INFO - mozsystemmonitor == 0.3 17:49:22 INFO - moztest == 0.8 17:49:22 INFO - mozversion == 1.4 17:49:22 INFO - psutil == 3.1.1 17:49:22 INFO - requests == 1.2.3 17:49:22 INFO - wsgiref == 0.1.2 17:49:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:49:22 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:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:22 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:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:22 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:22 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:49:22 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:49:22 INFO - Using env: {'DISPLAY': ':0', 17:49:22 INFO - 'HOME': '/home/cltbld', 17:49:22 INFO - 'LANG': 'en_US.UTF-8', 17:49:22 INFO - 'LANGUAGE': 'en_US:en', 17:49:22 INFO - 'LOGNAME': 'cltbld', 17:49:22 INFO - 'MAIL': '/var/mail/cltbld', 17:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:22 INFO - 'MOZ_NO_REMOTE': '1', 17:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:22 INFO - 'NO_EM_RESTART': '1', 17:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:22 INFO - 'PWD': '/builds/slave/test', 17:49:22 INFO - 'SHELL': '/bin/bash', 17:49:22 INFO - 'SHLVL': '1', 17:49:22 INFO - 'TERM': 'linux', 17:49:22 INFO - 'TMOUT': '86400', 17:49:22 INFO - 'USER': 'cltbld', 17:49:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:22 INFO - '_': '/tools/buildbot/bin/python'} 17:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:22 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:49:22 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:49:22 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:49:22 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:49:22 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:49:22 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:49:22 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:49:22 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:49:22 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:49:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:49:22 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:49:22 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:49:22 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:49:22 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:49:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:49:24 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:49:24 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:49:24 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:49:24 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:49:24 INFO - Installing collected packages: marionette-driver 17:49:24 INFO - Running setup.py install for marionette-driver 17:49:24 INFO - Successfully installed marionette-driver 17:49:24 INFO - Cleaning up... 17:49:24 INFO - Return code: 0 17:49:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:49:24 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 0x9cb3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', '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:49:24 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:49:24 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:49:24 INFO - Using env: {'DISPLAY': ':0', 17:49:24 INFO - 'HOME': '/home/cltbld', 17:49:24 INFO - 'LANG': 'en_US.UTF-8', 17:49:24 INFO - 'LANGUAGE': 'en_US:en', 17:49:24 INFO - 'LOGNAME': 'cltbld', 17:49:24 INFO - 'MAIL': '/var/mail/cltbld', 17:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:24 INFO - 'MOZ_NO_REMOTE': '1', 17:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:24 INFO - 'NO_EM_RESTART': '1', 17:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:24 INFO - 'PWD': '/builds/slave/test', 17:49:24 INFO - 'SHELL': '/bin/bash', 17:49:24 INFO - 'SHLVL': '1', 17:49:24 INFO - 'TERM': 'linux', 17:49:24 INFO - 'TMOUT': '86400', 17:49:24 INFO - 'USER': 'cltbld', 17:49:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:24 INFO - '_': '/tools/buildbot/bin/python'} 17:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:49:24 INFO - Cleaning up... 17:49:24 INFO - Return code: 0 17:49:24 INFO - Running post-action listener: _resource_record_post_action 17:49:24 INFO - Running post-action listener: _start_resource_monitoring 17:49:24 INFO - Starting resource monitoring. 17:49:24 INFO - [mozharness: 2017-06-06 00:49:24.561950Z] Finished create-virtualenv step (success) 17:49:24 INFO - [mozharness: 2017-06-06 00:49:24.562962Z] Running install step. 17:49:24 INFO - Running pre-action listener: _resource_record_pre_action 17:49:24 INFO - Running main action method: install 17:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:49:24 INFO - Reading from file tmpfile_stdout 17:49:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:49:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:49:24 INFO - Reading from file tmpfile_stdout 17:49:24 INFO - Output received: 17:49:24 INFO - Usage: mozinstall [options] installer 17:49:24 INFO - Options: 17:49:24 INFO - -h, --help show this help message and exit 17:49:24 INFO - -d DEST, --destination=DEST 17:49:24 INFO - Directory to install application into. [default: 17:49:24 INFO - "/builds/slave/test"] 17:49:24 INFO - --app=APP Application being installed. [default: firefox] 17:49:24 INFO - mkdir: /builds/slave/test/build/application 17:49:24 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:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:49:41 INFO - Reading from file tmpfile_stdout 17:49:41 INFO - Output received: 17:49:41 INFO - /builds/slave/test/build/application/firefox/firefox 17:49:41 INFO - Running post-action listener: _resource_record_post_action 17:49:41 INFO - [mozharness: 2017-06-06 00:49:41.810420Z] Finished install step (success) 17:49:41 INFO - [mozharness: 2017-06-06 00:49:41.810698Z] Running setup-mitmproxy step. 17:49:41 INFO - Running pre-action listener: _resource_record_pre_action 17:49:41 INFO - Running main action method: setup_mitmproxy 17:49:41 INFO - Skipping: mitmproxy is not required 17:49:41 INFO - Running post-action listener: _resource_record_post_action 17:49:41 INFO - [mozharness: 2017-06-06 00:49:41.811832Z] Finished setup-mitmproxy step (success) 17:49:41 INFO - [mozharness: 2017-06-06 00:49:41.812055Z] Running run-tests step. 17:49:41 INFO - Running pre-action listener: _resource_record_pre_action 17:49:41 INFO - Running main action method: run_tests 17:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:49:41 INFO - Python 2.7.3 17:49:41 INFO - Return code: 0 17:49:41 INFO - grabbing minidump binary from tooltool 17:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:49:41 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 0xd46840>, '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 0xd47740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:49:41 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:49:41 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:49:41 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:49:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:49:41 INFO - Return code: 0 17:49:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:49:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:49:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:49:41 INFO - ENV: RUST_BACKTRACE is now 1 17:49:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:49:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-040 --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:49:41 INFO - Using env: {'DISPLAY': ':0', 17:49:41 INFO - 'HOME': '/home/cltbld', 17:49:41 INFO - 'LANG': 'en_US.UTF-8', 17:49:41 INFO - 'LANGUAGE': 'en_US:en', 17:49:41 INFO - 'LOGNAME': 'cltbld', 17:49:41 INFO - 'MAIL': '/var/mail/cltbld', 17:49:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:49:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:49:41 INFO - 'MOZ_NO_REMOTE': '1', 17:49:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:49:41 INFO - 'NO_EM_RESTART': '1', 17:49:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:49:41 INFO - 'PWD': '/builds/slave/test', 17:49:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:49:41 INFO - 'RUST_BACKTRACE': '1', 17:49:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:49:41 INFO - 'SHELL': '/bin/bash', 17:49:41 INFO - 'SHLVL': '1', 17:49:41 INFO - 'TERM': 'linux', 17:49:41 INFO - 'TMOUT': '86400', 17:49:41 INFO - 'USER': 'cltbld', 17:49:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500', 17:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:49:41 INFO - '_': '/tools/buildbot/bin/python'} 17:49:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:49:42 INFO - mozversion application_buildid: 20170606001547 17:49:42 INFO - mozversion application_changeset: 3cfe81678881ada0245215c8863bc9722925bb44 17:49:42 INFO - mozversion application_display_name: Nightly 17:49:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:49:42 INFO - mozversion application_name: Firefox 17:49:42 INFO - mozversion application_remotingname: firefox 17:49:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:49:42 INFO - mozversion application_vendor: Mozilla 17:49:42 INFO - mozversion application_version: 55.0a1 17:49:42 INFO - mozversion platform_buildid: 20170606001547 17:49:42 INFO - mozversion platform_changeset: 3cfe81678881ada0245215c8863bc9722925bb44 17:49:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:49:42 INFO - mozversion platform_version: 55.0a1 17:49:42 INFO - using testdate: 1496710182 17:49:42 INFO - actual date: 1496710182 17:49:42 INFO - starting webserver on 'localhost:43013' 17:49:42 INFO - SUITE-START | Running 2 tests 17:49:42 INFO - TEST-START | dromaeo_css 17:49:42 INFO - operating with platform_type : linux_ 17:49:42 INFO - Initialising browser for dromaeo_css test... 17:49:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43013/getInfo.html -profile /tmp/tmprZE9eL/profile 17:49:42 INFO - TEST-INFO | started process 3303 (/builds/slave/test/build/application/firefox/firefox http://localhost:43013/getInfo.html) 17:50:19 INFO - TEST-INFO | 3303: killed by SIGTERM 17:50:19 INFO - Browser initialized. 17:50:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:50:19 INFO - TEST-INFO | started process 3511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprZE9eL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:31 INFO - PID 3511 | RSS: Main: 188350464 17:50:31 INFO - PID 3511 | 17:53:31 INFO - PID 3511 | Cycle 1(1): loaded http://localhost:43013/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43013/tests/dromaeo/cssquery-ext.html) 17:53:33 INFO - PID 3511 | RSS: Main: 183025664 17:53:33 INFO - PID 3511 | 17:56:34 INFO - PID 3511 | Cycle 1(1): loaded http://localhost:43013/tests/dromaeo/cssquery-ext.html (next: http://localhost:43013/tests/dromaeo/cssquery-jquery.html) 17:56:35 INFO - PID 3511 | RSS: Main: 188190720 17:56:35 INFO - PID 3511 | 17:59:37 INFO - PID 3511 | Cycle 1(1): loaded http://localhost:43013/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43013/tests/dromaeo/cssquery-mootools.html) 17:59:38 INFO - PID 3511 | RSS: Main: 184459264 17:59:38 INFO - PID 3511 | 18:02:39 INFO - PID 3511 | Cycle 1(1): loaded http://localhost:43013/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43013/tests/dromaeo/cssquery-prototype.html) 18:02:40 INFO - PID 3511 | RSS: Main: 190767104 18:02:40 INFO - PID 3511 | 18:05:43 INFO - PID 3511 | Cycle 1(1): loaded http://localhost:43013/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43013/tests/dromaeo/cssquery-yui.html) 18:05:43 INFO - PID 3511 | RSS: Main: 187994112 18:05:43 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | Cycle 1(1): loaded http://localhost:43013/tests/dromaeo/cssquery-yui.html (next: http://localhost:43013/tests/dromaeo/cssquery-dojo.html) 18:08:45 INFO - PID 3511 | RSS: Main: 187228160 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | __start_tp_report 18:08:45 INFO - PID 3511 | _x_x_mozilla_page_load 18:08:45 INFO - PID 3511 | _x_x_mozilla_page_load_details 18:08:45 INFO - PID 3511 | |i|pagename|runs| 18:08:45 INFO - PID 3511 | |0;dojo.html;3089.057837359605;3094.706002929721;3113.641931177915;3119.157827386605;3129.561861339413;5651.491365777089;5794.971025144879;5865.149553314772;5871.911921321178;5911.940880591198;5761.395053519383;5854.356020837705;5855.941440585593;5931.703414829263;5942.910856337158;5294.9939511492885;5400.621956463059;5434.538064264542;5445.482679145475;5455.318085239345;5538.723063846812;5569.387367389584;5574.442555744414;5580.107182850745;5587.273654424919;5319.122344813101;5346.358436987547;5375.516203541661;5421.241026256307;5484.561235101202;5395;5466.781328746845;5479.75341109651;5516.586256030773;5521.3926468088475;5392.406835248159;5404.378496472917;5413.621046526745;5454.4545545445535;5461.563074954034;5708.457696518824;5766.481016708516;5841.742431811362;5868.970655146697;5918.437748413894;6144.324124346318;6197.5351848611535;6213.502919766408;6215.34738852423;6234.937650623481;6364.109024736541;6364.395382438707;6367;6374.171357723466;6376.840578985516;5900.291964964232;5902.498287645555;5909.852253693692;5918.319393269786;5927.792527261525;6254.3745625438005;6315.336889626615;6376.744930202833;6414.454771344394;6444.645544495098;5953.851153721192;6020.729067191987;6068.120122582201;6158.107074474266;6229.844253893689;6262.467690246289;6268.843278918063;6278.623282603058;6280.246370435577;6296.622202667763;6284.937150628527;6295.087212354183;6306.3378345274;6309.747610095636;6312.873742525216;6103.246756470893;6162.445379915829;6245.250569931546;6310.7791227306825;6316.336784637547;5159.406668233126;5160.045391602565;5173.5602473789395;5173.71544565045;5204.76578553966;4402.053558484941;4407.845725399659;4414.580614841585;4415.227335216325;4463.4420697412825;5372.811951581676;5427.1045277528765;5511;5540.612157149041;5576.219329293902;6258.123862659231;6312.210973628296;6316.242050953915;6316.368363163739;6320;5486.067368547357;5492.395836457987;5494.972525137428;5500.092484739973;5555.91659626369;5391.514763671288;5563.582731295088;5587.32952045749;5589.133684278943;5591.944080559142;6031.698415079229;6071.605345652519;6089.878202435926;6131.54013449002;6132.141500189888;6298.149749783904;6299.496040316672;6302.621842689453;6308.558400911892;6330.113784070142;6098.420650038417;6100.145979562776;6117.174181485442;6132.141500189888;6133.754649813957;5986.700664966821;6045.667488288186;6129.114290130661;6200.348963358782;6229.408206220402;6288.056791481315;6335.366463353812;6342.080398342307;6345.206849143857;6363.96818015907;5963.821085367446;6163.137160797402;6168.19813424252;6168.321484636776;6172.537059720628;5949.672767997802;5963.314218864886;5977.731002104829;6131.529590167291;6132.9386706134155;6042.939570604238;6068.575199736153;6076.453119219292;6107.328193898757;6133.662648554372;6071.150038994632;6103.05402662588;6122.571420000735;6130.979101201984;6171.84570385744;6026.035834266497;6042.546808989431;6050.909236361546;6075.149479072845;6121.234845644294 18:08:45 INFO - PID 3511 | |1;ext.html;705.5131958948325;750.4671683104996;772.826114124322;1132.6828488023345;1146.403869987606;36420.45369319462;37435.43846842296;37609.623903760956;37614.43578346327;37649.43525847108;39377.40933885994;39684;39963;39970.20059598806;39998;7224.3136901994485;7340.082489688789;7375.704971801135;7446.441516886228;7513.436492263075;7374.151972523175;7480.17718051014;7480.8877866832045;7482.363999060087;7484.476086673935;7381.29877661624;7452.7391541296065;7479.5886226257535;7489.28851759082;7490.550566966;7407.111146662408;7458.552486850806;7462.626868656545;7463.179050304462;7469.439792015566;7199.280071992759;7232.783016509513;7234.385077268438;7236.529625574373;7238.638068096574;36147.819260903525;36473.08817279563;36520.269594608224;36527.4520882187;36544;3361.0757041813454;3394.2193295541915;3398.0655319787256;3399.6940275375086;3405.6594340565994;27852.303692407648;27967.30081747952;27989.86005069982;28097;28115.859420702767;3414.829258537088;3506.08841701157;3516.9472457913153;3517.6834084932225;3547.8048707321086;141559;145221;159403.2029839855;167958.16020919816;168913;42837.14325713468;43080.78459607682;43100.353494696974;43108.35337469941;43190;44584.55415445869;44666.33000504995;44827.32759008618;44856;45005.49945005473;13860.722785544232;14011.71976560463;14027.579172624837;14029.368678409292;14030.789538156936;11223.438828058564;11244.100471962223;11258.549658013751;11270.887291126985;11279.718007049889;13073.411696473682;13130.671733206555;13145.474181032652;13203.603891883258;13361.398737056856;5356.143017117242;5376.435474275223;5426.158945363475;5454.3454785426;5566.777328906879;924.9260059195249;926.7683079230193;969.7478655549608;974.7660561465198;978.9363691360039;23279.30162095106;23435.7656423437;23446.648300275167;23543.41141471443;23796.7620323798;1046.2728403759465;1060.3372891942536;1061.5965932945585;1075.7955988362187;1089.1885545268826;11789.823152652718;11889.762204755856;11913.28520288768;12440.129190956546;12488.81266780999;212783;214652;214996;215429;216721;47992.76003620029;48203;48216.758916205195;48252;48718.26922596164;1355.7288542291383;1400.3418393355107;1409.4150927365233;1425.836028856674;1428.1645237536159;20427.79572204259;21221.78778212198;22912.770872291065;23003.65494517617;23143.652845206998;34532.136696582784;34644.82677586596;34836.303273933874;34901.82549087238;34923.82538087395;171603;171732;171944;172004;172052;32380.83809580937;32683.346333072728;32850.50724239186;33496.80799476085;33615.83192084024;39560.40659390169;40091.398629020005;40239.396409054476;40374;40381.394279086424;28109.71890281071;28923.42153156883;29464.410711786073;29543.409131816814;31292.374152516368;29126.41747165087;29271.268218294714;29422.411551769274;31008.534871976488;31532.36935261236;33239.501407479394;33382.33235335328;33990.15024624305;34232.14419639529;35347.82326088353;28511.42977140404;29366.265843354086;30282.54576181315;30838.229044273176;31566.210844728146;21588.89205553962;23966.76033239715;24089.51820963606;24153.275401737978;24205 18:08:45 INFO - PID 3511 | |2;jquery.html;410.4725427825245;418.9410415968824;429.1502824407673;435.8692392282315;438.92318844202237;20093.497662558424;20872.582548349023;20957.58084838304;21944.341669749934;22782.65826012611;22664.66003009952;23213.18753843616;23216.3035108947;23248.76751232487;23276.418089547726;5929.614575052618;6067;6070.392960703938;6070.514358851304;6082.939170608303;5760.798372056979;5788.392218817026;5804.448577385142;5810.3027636683655;5811.389804070575;5776.306843178803;5782.248307720011;6018.8796224075495;6046.032634778437;6048.60684055535;5888.764449422039;5893.174955506232;5915.763369465216;5917.112433135021;5925.05199168131;5330.653507521999;5335.946640533583;5337.199420086979;5354.357477102733;5380.892382152335;25125.12062077837;25531.744682553122;25735.485290294087;25778.613320800203;25778.87110564454;1864.7296142059326;1920.5294702797764;1929.8552608554273;1934.1199754111844;1937.0702063009835;16274.75587866183;16781.734465847076;16879.83120168807;16934.745978810326;16944;2175.9564808703735;2232.765559616233;2242.3609271357586;2243.069126312578;2246.3373304874935;107294;109094;112462;115371.99999999916;115381;11811.88188118125;11906.761864762657;12017;12031.458584363725;12042.976347010426;16884;16939.23773430174;17036.744448833277;17055.91472042657;17065.232064557124;8597.828043439222;8671.089535598798;8766;8936.24041956441;9009.819803603892;8395.916040839636;8413.537255450887;8553.315734741205;8579.528125953133;8634.568271586395;7541.097591259002;7602.277783610548;7628.389728821681;7692.615369231628;7713.884291735629;2081.1363284237173;2092.4978005278927;2107.4099252209407;2139.8930053497575;2299.7930186283315;914.6798620482778;946.7549774250575;989.1641562879355;994.8806143262855;997.07272236819;17982.2807087715;18138.365157219436;18751.624967500848;18752.812471875106;18975.90512047431;940.3229674634252;959.6833045095102;970.2868391732071;973.5813600152003;1012.4380968562372;10101.393916364894;10146.543405546621;10420.426876521864;10642;10902.781944361068;409917;418407;431944;434859;437093;94804.52597736967;94974.52512737393;95111.52444237872;95985;97693.51153244189;1124.9775004499863;1136.267107715519;1201.5614300780153;1211.2127117373777;1218.6405010522094;17539.386121485688;18203.726944095586;18215.726764098283;19283.325083622007;19848.70226946626;46485.302720458545;46951.29573056338;48218.27672584844;48487;49572.50427495679;56138.7193064032;56418.435815641315;59577.40422595719;61088.69455652871;61857.690711547955;9987.550560224952;10007.09936105754;10045.899541004497;10101.24240681937;10113.14038306752;16791.74812377791;17269.56826079358;17320.566985825455;17471.82528174702;17832.19755111049;14404.207768572829;14539.636509087357;14569.125852448888;14610.634734131307;14672.26638668041;13081.103240030332;13230;13316.796007510704;13515.526956556474;13879.514217002357;14503.854961450672;14856;14929.104253744375;14961.925190373979;15017.17405542662;9723.951380243054;10125.139363154214;10154.339967902062;10168.694939151837;10189.388636681822;13677.658058548615;13698.767110960061;13793.931030344784;13847;13958.511452099128 18:08:45 INFO - PID 3511 | |3;mootools.html;1281.6475469245959;1318.2683610596127;1325.8077578751079;1339.845917719462;1342.583799022303;10720.195985301094;11251.493682784274;11281.210315277924;11296.830547541793;11586;11142.387168705718;11329.0936725062;11341.886581134186;11358.886411135885;11361.261518001324;2243.5288589396205;2305.700258966332;2306.2965795432387;2309.6766452696634;2315.513742114158;2243.4839986803045;2310.7342655594653;2312.838101332907;2317.7102862142233;2328.1036800831716;2242.1703969531295;2244.5623103494827;2268.6370180771078;2275.8065564427043;2276.4536511237266;2241.3051953894183;2242.3273018094587;2244.472548950995;2247.4156719252946;2257.1761307122947;2211.1155537784853;2219.411855858199;2223.555288942218;2226.944326391837;2236.2508559632543;10556.78886422275;10661.946690266577;10690.144788416908;10709.625163119332;10735.194860385502;5887;6106.145139680449;6108.297545782248;6109.755609775603;6131.96934015327;3490.458978858281;3615.7649752765988;3631.800250986195;3641.253543023674;3651.3427583035045;1279.1301914698001;1296.455488694741;1331.8268625078774;1336.866313368665;1339.5981205638368;15990.360385584563;16193.757093643604;16238.512844614681;16367;16561.66876662472;4892.50482254053;4902.7058376497525;5017.3226614406585;5040.647154699209;5057.494250574987;11555.76888462226;11621.418929053683;11624.186306958432;11631.53473861053;11679.649610511698;6063.060225664941;6163.660998645118;6175.382461753788;6175.413335733098;6179.938200617937;5716.714164291769;5785.623934444247;5801.9419805802245;5802.303723553201;5804.94195058044;4147.605977432139;4149.771762553029;4219.810108545123;4240.915181696349;4256.659152366995;1209.7580483903255;1227.8035514317667;1233.543588872123;1260.6092111445482;1264.2225031605496;843.2242337049929;860.9827803443897;886;894.6376717429322;916.9449833010041;6085;6185.257769067741;6370.299267080617;6405.398650337415;6488.708008139645;608.2336256316984;614.7510258345377;618.35073173168;620.6214209332304;622.1942584353274;4016.196760647882;4058.228936502055;4226.387173859773;4701.318308845198;4721.15019296523;13649.317534123255;14042.297885105909;14082.788758168635;14119.152850828983;14134.434622615187;13984.440622375194;13989.901514772662;14012.789808152886;14085.929570352082;14152.43390264378;8445.57772111392;8584.356173287028;8760.386772925962;8833.823323533494;8834.690785822466;6622.254405020517;6665.733370665119;6669.566478178903;6898.271691149044;7244.89132663;12866.35668216604;12969.35153242353;13010.479580816662;13185.011124165918;13324.800127997894;13080;13182.80225796633;13215.07494475416;13295.268760217894;13350.265735384648;9240.815183696423;9447.102525260088;9458.716238512856;9492.288078394286;9497.335186537153;10577.471126443801;10938.835917461085;11022.228444009163;11028.889711103107;11067.72330691739;9071.863922041306;9214.124658157465;9259.166674999282;9319.767005824908;9462.621495140118;8754.299656027375;8986.955065224633;9004.50475223869;9024.684136055206;9173.40372875761;8067.515949043076;8166.305864001389;8195.426320157532;8206.302464290602;8232.382571307056;6048.667323297261;6253.562250642593;6322.715477803418;6363.236411630634;6477.935220647922;6268.558231606848;6389.520785941166;6517.674116294072;6604.3725846044545;6644.468442524683 18:08:45 INFO - PID 3511 | |4;prototype.html;382.78755290813604;395.6478733926805;403.02669054234025;404.45600667102747;405.5376870367779;6207.751689932408;6382.808675584687;6384.904226436607;6421.903671444932;6425.38958798914;6067.211262535875;6165.3834616538325;6179.382061793818;6181.320054793969;6184.598001129923;4820.542048505386;4825.348577941985;4829.9275510867365;4834.7824347904425;4836.250381190921;4833.105875413043;4837.274408838684;4850.830220942268;4858.684185527947;4861.246506791453;4767.475577686451;4791.717673393737;4799.160146974283;4811.735354555498;4813.951860481403;4813.157697402958;4826.107170173529;4827.734474603895;4833.734144622044;4835.395575553056;4199.601037901425;4202.6847986400835;4205.684573656988;4217.683673724483;4220.198162349144;6140.83324168411;6157.261128664589;6162.661053642048;6163.753449862;6204.83553387771;5520.972395138038;5522.861928451781;5524.58565607577;5529.612927095105;5534.4742249486235;6558.114654521626;6612.718612078825;6628.171478565179;6634.635095069769;6637.336266373372;4604.723716577016;4606.585407313324;4613.584777370019;4616.584507394351;4620.491745907947;6578.210614726216;6915.550489218235;6970.30296970304;6972.755953541652;7064.258252883425;4637.698549594265;4664.370310008106;4685;4685;4691.7654117294;4641.512641172696;4739.4075740532435;4743.549362810528;4745.193317136095;4751.239801631722;5280.234366016906;5452.59105567084;5490.0941344677685;5524.116141417354;5571.359293681197;6586.835314142578;6655;6665.700043498055;6676.365745254193;6698.866022679616;1604.767308740226;1618.2313401134602;1627.471071901613;1633.428300094981;1634.4687976407715;1058.867641544807;1101.7025403141106;1104.3870651788175;1106.5131342209402;1113.3709454158375;5800.332961709373;5800.810833779065;5856.736446859902;5864.237649105589;5898.262717160355;6739.629320387426;6794.93205067943;6819.55672881271;6858.5199036068;6899.413549848218;5779.306483222041;5783.566232532577;5796.565257605696;5831.825045248649;5849.61977471463;3614.7288953328607;3647.854085836537;3660.871869484555;3680.6135355787255;3691.57546882112;6635.668216589152;6658.733650654017;6673.899891501631;6680.23177334603;6687.431568316651;6977.51157418986;6990.161180658251;7020.473464490082;7029.859402811915;7038.577685338793;6591.307912669196;6640.705062512764;6650.501212409089;6651.301613330627;6658.1011563438315;6801.047853300641;6816.147981502312;6824.249332573314;6847.1783385994;6865.794026179223;6543.70553325111;6795.218549866829;6798.558093723892;6804.183497980274;6837.453003759787;6200.596961197508;6505.41451269388;6568.7372505099265;6580.894113883512;6622.768203112868;4672.813087476463;4697.976510117427;4699.475393454909;4699.835505757282;4721.858344249678;6810.965945170243;6817.216020157745;6851.760188393382;6853.5109503275435;6861.2795656455355;6406.9359306408205;6630.635315057718;6641.575824824001;6678.365555272241;6680.198376194693;6597.6701164940605;6617.371349721769;6618.172728408949;6624.801255962136;6653.767118150841;6540.444062254572;6587;6592.307807680125;6598.449364399458;6656.7004484797335;6665.700043497957;6703.430208432338;6732.798016059526;6745.190577130776;6758.594484330956;6376.74493020274;6431.83920401975;6462.515311351762;6468.644224567505;6503.739850405931 18:08:45 INFO - PID 3511 | |5;yui.html;770.6763159473021;788.1724189600917;813.4549851599428;818.7666515043212;837.5812093953022;16547.42084027059;17100.486985390442;17125;17804.91097544514;19530.31643892464;18339.816601833976;18438.631227375477;18690.71963920542;18692.345767898125;18697.90651046743;945.2579724915943;973.9707808765713;980.289290264556;983.0415345038601;983.6557204978272;954.9952250238774;986.8470387090013;999.9500024998757;1003.4029752297372;1005.2812239248935;1033.8604288421043;1039.064841642524;1039.365986748083;1039.3763741754924;1039.9064084232418;1034;1034.0331789776546;1035.8756949166072;1036.1503567075001;1037.2842738510442;754.2156157596094;754.5510421299318;758.5221310574358;758.6168984662766;759.779663897469;16156.434524791575;17147.57131071721;17286.222120004506;17508.824911750846;17533.123343832885;18425.170867311004;18492.07539623027;18861.434156975174;18873.811261887342;18952.52618684544;14403.855961440357;14614.488492902803;14625.926870365687;14700.632484187874;14701.926490367587;3340.515625234327;3383.796972181677;3396.117009577503;3412.4198886189406;3418.077119177808;97386.51306743492;97730.51134744352;97892;97929.51035244849;99927.50036249845;14401.42394304216;14688.853111468963;14698.926505367619;14975.550733478012;14994.175320357484;25819.483610327687;26936.865315673294;27198.45603087927;27210.727892721214;27243;7565.092188937363;7711.383089352838;7770.961145194238;7793.18171591986;7838.568878711726;3714.3685573452576;3804.714646401531;3805.37211360128;3809.1810260794064;3821.063839359375;3850.961490385116;3917.1578110706337;3918.1771827916455;3924.0778417071965;4481.641468682497;878.2490970220497;895.8700988356782;897.6804097975964;898.6879156431553;898.9572096368312;661.256086902235;669.9799006029826;671.6171782084165;675.76010516267;676.9153855768029;10410.531526081344;11496.655100347003;12146.574869879512;12286.631401057983;12416.75166496665;645.5190882792256;651.9217693876765;658.4271683635268;662.7084083003463;681.7613835157655;4649.232876575395;5076.7207803571155;5349.331333583302;5416.2149854224235;5810.535157187415;89657.55171224102;90753.54623226974;91089.08910910938;91125;92448.53775731212;80064.19935800684;81494.59252703699;81626.59186704029;81664;81765;68015;69842;72178;73408.63295683594;73658.63170684219;11553;12475.93762031184;12492.750144997231;12583.496660133493;12691.619251422471;29322.853385732935;29515.40969180647;29814;29847.552286716153;30903.536446953764;37733.24533509369;37943;38130.237395252494;38212.808935955145;39391.80304098461;16621.916890415472;16684.749728754323;16975.915120424317;17163.227654755814;17589;17856.821431785516;18296;18805;19288.90355548213;19575.510612234808;16239.59401014984;16475.17624118765;17092.230849611547;18263;18609.16258768386;16783.580410489834;17811.821881781016;18263.08684565793;18669.43991680252;19170.808291916903;16832.495025148775;17841.46475605734;17924.462266132035;18528.44414667562;18550.81449185545;11366.318020918441;11879.643610691694;11893.881061189277;12137.817932731192;12390.380480976095;13064.693530646859;13083.934580327037;13136.540221092599;14047.297635118408;14195.503157389441 18:08:45 INFO - PID 3511 | __end_tp_report 18:08:45 INFO - PID 3511 | __start_cc_report 18:08:45 INFO - PID 3511 | _x_x_mozilla_cycle_collect,384 18:08:45 INFO - PID 3511 | __end_cc_report 18:08:45 INFO - PID 3511 | __startTimestamp1496711325838__endTimestamp 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | ------- Summary: start ------- 18:08:45 INFO - PID 3511 | Number of tests: 6 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | [#0] dojo.html Cycles:165 Average:5801.60 Median:6026.04 stddev:642.97 (10.7%) stddev-sans-first:608.72 18:08:45 INFO - PID 3511 | Values: 3089.1 3094.7 3113.6 3119.2 3129.6 5651.5 5795.0 5865.1 5871.9 5911.9 5761.4 5854.4 5855.9 5931.7 5942.9 5295.0 5400.6 5434.5 5445.5 5455.3 5538.7 5569.4 5574.4 5580.1 5587.3 5319.1 5346.4 5375.5 5421.2 5484.6 5395.0 5466.8 5479.8 5516.6 5521.4 5392.4 5404.4 5413.6 5454.5 5461.6 5708.5 5766.5 5841.7 5869.0 5918.4 6144.3 6197.5 6213.5 6215.3 6234.9 6364.1 6364.4 6367.0 6374.2 6376.8 5900.3 5902.5 5909.9 5918.3 5927.8 6254.4 6315.3 6376.7 6414.5 6444.6 5953.9 6020.7 6068.1 6158.1 6229.8 6262.5 6268.8 6278.6 6280.2 6296.6 6284.9 6295.1 6306.3 6309.7 6312.9 6103.2 6162.4 6245.3 6310.8 6316.3 5159.4 5160.0 5173.6 5173.7 5204.8 4402.1 4407.8 4414.6 4415.2 4463.4 5372.8 5427.1 5511.0 5540.6 5576.2 6258.1 6312.2 6316.2 6316.4 6320.0 5486.1 5492.4 5495.0 5500.1 5555.9 5391.5 5563.6 5587.3 5589.1 5591.9 6031.7 6071.6 6089.9 6131.5 6132.1 6298.1 6299.5 6302.6 6308.6 6330.1 6098.4 6100.1 6117.2 6132.1 6133.8 5986.7 6045.7 6129.1 6200.3 6229.4 6288.1 6335.4 6342.1 6345.2 6364.0 5963.8 6163.1 6168.2 6168.3 6172.5 5949.7 5963.3 5977.7 6131.5 6132.9 6042.9 6068.6 6076.5 6107.3 6133.7 6071.2 6103.1 6122.6 6131.0 6171.8 6026.0 6042.5 6050.9 6075.1 6121.2 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | [#1] ext.html Cycles:180 Average:34058.86 Median:3396.14 stddev:47341.03 (1394.0%) stddev-sans-first:47407.58 18:08:45 INFO - PID 3511 | Values: 705.5 750.5 772.8 1132.7 1146.4 36420.5 37435.4 37609.6 37614.4 37649.4 39377.4 39684.0 39963.0 39970.2 39998.0 7224.3 7340.1 7375.7 7446.4 7513.4 7374.2 7480.2 7480.9 7482.4 7484.5 7381.3 7452.7 7479.6 7489.3 7490.6 7407.1 7458.6 7462.6 7463.2 7469.4 7199.3 7232.8 7234.4 7236.5 7238.6 36147.8 36473.1 36520.3 36527.5 36544.0 3361.1 3394.2 3398.1 3399.7 3405.7 27852.3 27967.3 27989.9 28097.0 28115.9 3414.8 3506.1 3516.9 3517.7 3547.8 141559.0 145221.0 159403.2 167958.2 168913.0 42837.1 43080.8 43100.4 43108.4 43190.0 44584.6 44666.3 44827.3 44856.0 45005.5 13860.7 14011.7 14027.6 14029.4 14030.8 11223.4 11244.1 11258.5 11270.9 11279.7 13073.4 13130.7 13145.5 13203.6 13361.4 5356.1 5376.4 5426.2 5454.3 5566.8 924.9 926.8 969.7 974.8 978.9 23279.3 23435.8 23446.6 23543.4 23796.8 1046.3 1060.3 1061.6 1075.8 1089.2 11789.8 11889.8 11913.3 12440.1 12488.8 212783.0 214652.0 214996.0 215429.0 216721.0 47992.8 48203.0 48216.8 48252.0 48718.3 1355.7 1400.3 1409.4 1425.8 1428.2 20427.8 21221.8 22912.8 23003.7 23143.7 34532.1 34644.8 34836.3 34901.8 34923.8 171603.0 171732.0 171944.0 172004.0 172052.0 32380.8 32683.3 32850.5 33496.8 33615.8 39560.4 40091.4 40239.4 40374.0 40381.4 28109.7 28923.4 29464.4 29543.4 31292.4 29126.4 29271.3 29422.4 31008.5 31532.4 33239.5 33382.3 33990.2 34232.1 35347.8 28511.4 29366.3 30282.5 30838.2 31566.2 21588.9 23966.8 24089.5 24153.3 24205.0 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | [#2] jquery.html Cycles:180 Average:29507.44 Median:2244.70 stddev:71489.62 (3184.8%) stddev-sans-first:71656.78 18:08:45 INFO - PID 3511 | Values: 410.5 418.9 429.2 435.9 438.9 20093.5 20872.6 20957.6 21944.3 22782.7 22664.7 23213.2 23216.3 23248.8 23276.4 5929.6 6067.0 6070.4 6070.5 6082.9 5760.8 5788.4 5804.4 5810.3 5811.4 5776.3 5782.2 6018.9 6046.0 6048.6 5888.8 5893.2 5915.8 5917.1 5925.1 5330.7 5335.9 5337.2 5354.4 5380.9 25125.1 25531.7 25735.5 25778.6 25778.9 1864.7 1920.5 1929.9 1934.1 1937.1 16274.8 16781.7 16879.8 16934.7 16944.0 2176.0 2232.8 2242.4 2243.1 2246.3 107294.0 109094.0 112462.0 115372.0 115381.0 11811.9 11906.8 12017.0 12031.5 12043.0 16884.0 16939.2 17036.7 17055.9 17065.2 8597.8 8671.1 8766.0 8936.2 9009.8 8395.9 8413.5 8553.3 8579.5 8634.6 7541.1 7602.3 7628.4 7692.6 7713.9 2081.1 2092.5 2107.4 2139.9 2299.8 914.7 946.8 989.2 994.9 997.1 17982.3 18138.4 18751.6 18752.8 18975.9 940.3 959.7 970.3 973.6 1012.4 10101.4 10146.5 10420.4 10642.0 10902.8 409917.0 418407.0 431944.0 434859.0 437093.0 94804.5 94974.5 95111.5 95985.0 97693.5 1125.0 1136.3 1201.6 1211.2 1218.6 17539.4 18203.7 18215.7 19283.3 19848.7 46485.3 46951.3 48218.3 48487.0 49572.5 56138.7 56418.4 59577.4 61088.7 61857.7 9987.6 10007.1 10045.9 10101.2 10113.1 16791.7 17269.6 17320.6 17471.8 17832.2 14404.2 14539.6 14569.1 14610.6 14672.3 13081.1 13230.0 13316.8 13515.5 13879.5 14503.9 14856.0 14929.1 14961.9 15017.2 9724.0 10125.1 10154.3 10168.7 10189.4 13677.7 13698.8 13793.9 13847.0 13958.5 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | [#3] mootools.html Cycles:180 Average:6907.40 Median:3553.11 stddev:4387.57 (123.5%) stddev-sans-first:4379.51 18:08:45 INFO - PID 3511 | Values: 1281.6 1318.3 1325.8 1339.8 1342.6 10720.2 11251.5 11281.2 11296.8 11586.0 11142.4 11329.1 11341.9 11358.9 11361.3 2243.5 2305.7 2306.3 2309.7 2315.5 2243.5 2310.7 2312.8 2317.7 2328.1 2242.2 2244.6 2268.6 2275.8 2276.5 2241.3 2242.3 2244.5 2247.4 2257.2 2211.1 2219.4 2223.6 2226.9 2236.3 10556.8 10661.9 10690.1 10709.6 10735.2 5887.0 6106.1 6108.3 6109.8 6132.0 3490.5 3615.8 3631.8 3641.3 3651.3 1279.1 1296.5 1331.8 1336.9 1339.6 15990.4 16193.8 16238.5 16367.0 16561.7 4892.5 4902.7 5017.3 5040.6 5057.5 11555.8 11621.4 11624.2 11631.5 11679.6 6063.1 6163.7 6175.4 6175.4 6179.9 5716.7 5785.6 5801.9 5802.3 5804.9 4147.6 4149.8 4219.8 4240.9 4256.7 1209.8 1227.8 1233.5 1260.6 1264.2 843.2 861.0 886.0 894.6 916.9 6085.0 6185.3 6370.3 6405.4 6488.7 608.2 614.8 618.4 620.6 622.2 4016.2 4058.2 4226.4 4701.3 4721.2 13649.3 14042.3 14082.8 14119.2 14134.4 13984.4 13989.9 14012.8 14085.9 14152.4 8445.6 8584.4 8760.4 8833.8 8834.7 6622.3 6665.7 6669.6 6898.3 7244.9 12866.4 12969.4 13010.5 13185.0 13324.8 13080.0 13182.8 13215.1 13295.3 13350.3 9240.8 9447.1 9458.7 9492.3 9497.3 10577.5 10938.8 11022.2 11028.9 11067.7 9071.9 9214.1 9259.2 9319.8 9462.6 8754.3 8987.0 9004.5 9024.7 9173.4 8067.5 8166.3 8195.4 8206.3 8232.4 6048.7 6253.6 6322.7 6363.2 6477.9 6268.6 6389.5 6517.7 6604.4 6644.5 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | [#4] prototype.html Cycles:180 Average:5487.54 Median:6172.38 stddev:1632.55 (26.4%) stddev-sans-first:1591.53 18:08:45 INFO - PID 3511 | Values: 382.8 395.6 403.0 404.5 405.5 6207.8 6382.8 6384.9 6421.9 6425.4 6067.2 6165.4 6179.4 6181.3 6184.6 4820.5 4825.3 4829.9 4834.8 4836.3 4833.1 4837.3 4850.8 4858.7 4861.2 4767.5 4791.7 4799.2 4811.7 4814.0 4813.2 4826.1 4827.7 4833.7 4835.4 4199.6 4202.7 4205.7 4217.7 4220.2 6140.8 6157.3 6162.7 6163.8 6204.8 5521.0 5522.9 5524.6 5529.6 5534.5 6558.1 6612.7 6628.2 6634.6 6637.3 4604.7 4606.6 4613.6 4616.6 4620.5 6578.2 6915.6 6970.3 6972.8 7064.3 4637.7 4664.4 4685.0 4685.0 4691.8 4641.5 4739.4 4743.5 4745.2 4751.2 5280.2 5452.6 5490.1 5524.1 5571.4 6586.8 6655.0 6665.7 6676.4 6698.9 1604.8 1618.2 1627.5 1633.4 1634.5 1058.9 1101.7 1104.4 1106.5 1113.4 5800.3 5800.8 5856.7 5864.2 5898.3 6739.6 6794.9 6819.6 6858.5 6899.4 5779.3 5783.6 5796.6 5831.8 5849.6 3614.7 3647.9 3660.9 3680.6 3691.6 6635.7 6658.7 6673.9 6680.2 6687.4 6977.5 6990.2 7020.5 7029.9 7038.6 6591.3 6640.7 6650.5 6651.3 6658.1 6801.0 6816.1 6824.2 6847.2 6865.8 6543.7 6795.2 6798.6 6804.2 6837.5 6200.6 6505.4 6568.7 6580.9 6622.8 4672.8 4698.0 4699.5 4699.8 4721.9 6811.0 6817.2 6851.8 6853.5 6861.3 6406.9 6630.6 6641.6 6678.4 6680.2 6597.7 6617.4 6618.2 6624.8 6653.8 6540.4 6587.0 6592.3 6598.4 6656.7 6665.7 6703.4 6732.8 6745.2 6758.6 6376.7 6431.8 6462.5 6468.6 6503.7 18:08:45 INFO - PID 3511 | 18:08:45 INFO - PID 3511 | [#5] yui.html Cycles:180 Average:19698.09 Median:27226.86 stddev:25256.43 (92.8%) stddev-sans-first:25287.29 18:08:45 INFO - PID 3511 | Values: 770.7 788.2 813.5 818.8 837.6 16547.4 17100.5 17125.0 17804.9 19530.3 18339.8 18438.6 18690.7 18692.3 18697.9 945.3 974.0 980.3 983.0 983.7 955.0 986.8 1000.0 1003.4 1005.3 1033.9 1039.1 1039.4 1039.4 1039.9 1034.0 1034.0 1035.9 1036.2 1037.3 754.2 754.6 758.5 758.6 759.8 16156.4 17147.6 17286.2 17508.8 17533.1 18425.2 18492.1 18861.4 18873.8 18952.5 14403.9 14614.5 14625.9 14700.6 14701.9 3340.5 3383.8 3396.1 3412.4 3418.1 97386.5 97730.5 97892.0 97929.5 99927.5 14401.4 14688.9 14698.9 14975.6 14994.2 25819.5 26936.9 27198.5 27210.7 27243.0 7565.1 7711.4 7771.0 7793.2 7838.6 3714.4 3804.7 3805.4 3809.2 3821.1 3851.0 3917.2 3918.2 3924.1 4481.6 878.2 895.9 897.7 898.7 899.0 661.3 670.0 671.6 675.8 676.9 10410.5 11496.7 12146.6 12286.6 12416.8 645.5 651.9 658.4 662.7 681.8 4649.2 5076.7 5349.3 5416.2 5810.5 89657.6 90753.5 91089.1 91125.0 92448.5 80064.2 81494.6 81626.6 81664.0 81765.0 68015.0 69842.0 72178.0 73408.6 73658.6 11553.0 12475.9 12492.8 12583.5 12691.6 29322.9 29515.4 29814.0 29847.6 30903.5 37733.2 37943.0 38130.2 38212.8 39391.8 16621.9 16684.7 16975.9 17163.2 17589.0 17856.8 18296.0 18805.0 19288.9 19575.5 16239.6 16475.2 17092.2 18263.0 18609.2 16783.6 17811.8 18263.1 18669.4 19170.8 16832.5 17841.5 17924.5 18528.4 18550.8 11366.3 11879.6 11893.9 12137.8 12390.4 13064.7 13083.9 13136.5 14047.3 14195.5 18:08:45 INFO - PID 3511 | -------- Summary: end -------- 18:08:45 INFO - PID 3511 | 18:08:46 INFO - TEST-INFO | 3511: exit 0 18:08:46 INFO - TEST-OK | dromaeo_css | took 1144430ms 18:08:46 INFO - TEST-START | kraken 18:08:46 INFO - operating with platform_type : linux_ 18:08:46 INFO - Initialising browser for kraken test... 18:08:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43013/getInfo.html -profile /tmp/tmpOT4zs5/profile 18:08:46 INFO - TEST-INFO | started process 3913 (/builds/slave/test/build/application/firefox/firefox http://localhost:43013/getInfo.html) 18:09:21 INFO - TEST-INFO | 3913: killed by SIGTERM 18:09:21 INFO - Browser initialized. 18:09:21 INFO - Running cycle 1/1 for kraken test... 18:09:21 INFO - TEST-INFO | started process 4120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOT4zs5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:33 INFO - PID 4120 | RSS: Main: 187428864 18:09:33 INFO - PID 4120 | 18:09:35 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43013/tests/kraken/driver.html?testName=audio-beat-detection) 18:09:36 INFO - PID 4120 | RSS: Main: 190873600 18:09:36 INFO - PID 4120 | 18:09:39 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43013/tests/kraken/driver.html?testName=audio-dft) 18:09:39 INFO - PID 4120 | RSS: Main: 189960192 18:09:39 INFO - PID 4120 | 18:09:42 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43013/tests/kraken/driver.html?testName=audio-fft) 18:09:43 INFO - PID 4120 | RSS: Main: 185061376 18:09:43 INFO - PID 4120 | 18:09:45 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43013/tests/kraken/driver.html?testName=audio-oscillator) 18:09:46 INFO - PID 4120 | RSS: Main: 186212352 18:09:46 INFO - PID 4120 | 18:09:48 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43013/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:09:48 INFO - PID 4120 | RSS: Main: 186183680 18:09:48 INFO - PID 4120 | 18:09:51 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43013/tests/kraken/driver.html?testName=imaging-darkroom) 18:09:52 INFO - PID 4120 | RSS: Main: 186945536 18:09:52 INFO - PID 4120 | 18:09:56 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43013/tests/kraken/driver.html?testName=imaging-desaturate) 18:09:56 INFO - PID 4120 | RSS: Main: 186961920 18:09:56 INFO - PID 4120 | 18:09:59 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43013/tests/kraken/driver.html?testName=json-parse-financial) 18:10:00 INFO - PID 4120 | RSS: Main: 187482112 18:10:00 INFO - PID 4120 | 18:10:01 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43013/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:02 INFO - PID 4120 | RSS: Main: 187703296 18:10:02 INFO - PID 4120 | 18:10:04 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:04 INFO - PID 4120 | RSS: Main: 187199488 18:10:04 INFO - PID 4120 | 18:10:07 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:07 INFO - PID 4120 | RSS: Main: 187252736 18:10:07 INFO - PID 4120 | 18:10:10 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:10:11 INFO - PID 4120 | RSS: Main: 186798080 18:10:11 INFO - PID 4120 | 18:10:14 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:10:14 INFO - PID 4120 | RSS: Main: 187297792 18:10:14 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:43013/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43013/tests/kraken/driver.html?testName=ai-astar) 18:10:16 INFO - PID 4120 | RSS: Main: 188440576 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | __start_tp_report 18:10:16 INFO - PID 4120 | _x_x_mozilla_page_load 18:10:16 INFO - PID 4120 | _x_x_mozilla_page_load_details 18:10:16 INFO - PID 4120 | |i|pagename|runs| 18:10:16 INFO - PID 4120 | |0;ai-astar;102;110;111;108;110;111;111;109;111;111 18:10:16 INFO - PID 4120 | |1;audio-beat-detection;146;120;124;167;121;121;124;121;144;121 18:10:16 INFO - PID 4120 | |2;audio-dft;165;166;163;163;161;164;164;169;173;164 18:10:16 INFO - PID 4120 | |3;audio-fft;72;73;73;114;73;85;76;73;93;74 18:10:16 INFO - PID 4120 | |4;audio-oscillator;82;81;105;82;82;82;93;81;82;102 18:10:16 INFO - PID 4120 | |5;imaging-gaussian-blur;115;115;115;114;114;114;114;114;114;113 18:10:16 INFO - PID 4120 | |6;imaging-darkroom;151;150;151;151;150;151;151;150;150;151 18:10:16 INFO - PID 4120 | |7;imaging-desaturate;94;94;95;95;94;94;94;95;95;94 18:10:16 INFO - PID 4120 | |8;json-parse-financial;56;58;55;55;55;56;57;59;55;56 18:10:16 INFO - PID 4120 | |9;json-stringify-tinderbox;55;57;61;55;55;55;56;57;55;57 18:10:16 INFO - PID 4120 | |10;stanford-crypto-aes;89;87;87;86;87;86;91;89;114;90 18:10:16 INFO - PID 4120 | |11;stanford-crypto-ccm;132;129;133;131;129;134;130;130;133;147 18:10:16 INFO - PID 4120 | |12;stanford-crypto-pbkdf2;195;189;198;206;192;206;199;196;200;195 18:10:16 INFO - PID 4120 | |13;stanford-crypto-sha256-iterative;74;74;74;71;74;71;70;71;70;73 18:10:16 INFO - PID 4120 | __end_tp_report 18:10:16 INFO - PID 4120 | __start_cc_report 18:10:16 INFO - PID 4120 | _x_x_mozilla_cycle_collect,994 18:10:16 INFO - PID 4120 | __end_cc_report 18:10:16 INFO - PID 4120 | __startTimestamp1496711416859__endTimestamp 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | ------- Summary: start ------- 18:10:16 INFO - PID 4120 | Number of tests: 14 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:2.80 (2.5%) stddev-sans-first:1.09 18:10:16 INFO - PID 4120 | Values: 102.0 110.0 111.0 108.0 110.0 111.0 111.0 109.0 111.0 111.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:124.00 stddev:16.02 (12.9%) stddev-sans-first:16.03 18:10:16 INFO - PID 4120 | Values: 146.0 120.0 124.0 167.0 121.0 121.0 124.0 121.0 144.0 121.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:3.46 (2.1%) stddev-sans-first:3.67 18:10:16 INFO - PID 4120 | Values: 165.0 166.0 163.0 163.0 161.0 164.0 164.0 169.0 173.0 164.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.50 stddev:13.57 (18.5%) stddev-sans-first:14.04 18:10:16 INFO - PID 4120 | Values: 72.0 73.0 73.0 114.0 73.0 85.0 76.0 73.0 93.0 74.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:82.00 stddev:9.32 (11.4%) stddev-sans-first:9.69 18:10:16 INFO - PID 4120 | Values: 82.0 81.0 105.0 82.0 82.0 82.0 93.0 81.0 82.0 102.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 18:10:16 INFO - PID 4120 | Values: 115.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 18:10:16 INFO - PID 4120 | Values: 151.0 150.0 151.0 151.0 150.0 151.0 151.0 150.0 150.0 151.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:10:16 INFO - PID 4120 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 18:10:16 INFO - PID 4120 | Values: 56.0 58.0 55.0 55.0 55.0 56.0 57.0 59.0 55.0 56.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.50 stddev:1.89 (3.3%) stddev-sans-first:1.94 18:10:16 INFO - PID 4120 | Values: 55.0 57.0 61.0 55.0 55.0 55.0 56.0 57.0 55.0 57.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:88.00 stddev:8.40 (9.5%) stddev-sans-first:8.89 18:10:16 INFO - PID 4120 | Values: 89.0 87.0 87.0 86.0 87.0 86.0 91.0 89.0 114.0 90.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.50 stddev:5.29 (4.0%) stddev-sans-first:5.60 18:10:16 INFO - PID 4120 | Values: 132.0 129.0 133.0 131.0 129.0 134.0 130.0 130.0 133.0 147.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:198.50 stddev:5.48 (2.8%) stddev-sans-first:5.73 18:10:16 INFO - PID 4120 | Values: 195.0 189.0 198.0 206.0 192.0 206.0 199.0 196.0 200.0 195.0 18:10:16 INFO - PID 4120 | 18:10:16 INFO - PID 4120 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.50 stddev:1.75 (2.4%) stddev-sans-first:1.73 18:10:16 INFO - PID 4120 | Values: 74.0 74.0 74.0 71.0 74.0 71.0 70.0 71.0 70.0 73.0 18:10:16 INFO - PID 4120 | -------- Summary: end -------- 18:10:16 INFO - PID 4120 | 18:10:18 INFO - TEST-INFO | 4120: exit 0 18:10:18 INFO - TEST-OK | kraken | took 91343ms 18:10:18 INFO - SUITE-END | took 1235s 18:10:18 INFO - Completed test suite (00:20:36) 18:10:18 INFO - javascript benchmark 18:10:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7632.471531237491, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.057837359605, 3094.706002929721, 3113.641931177915, 3119.157827386605, 3129.561861339413, 5651.491365777089, 5794.971025144879, 5865.149553314772, 5871.911921321178, 5911.940880591198, 5761.395053519383, 5854.356020837705, 5855.941440585593, 5931.703414829263, 5942.910856337158, 5294.9939511492885, 5400.621956463059, 5434.538064264542, 5445.482679145475, 5455.318085239345, 5538.723063846812, 5569.387367389584, 5574.442555744414, 5580.107182850745, 5587.273654424919, 5319.122344813101, 5346.358436987547, 5375.516203541661, 5421.241026256307, 5484.561235101202, 5395.0, 5466.781328746845, 5479.75341109651, 5516.586256030773, 5521.3926468088475, 5392.406835248159, 5404.378496472917, 5413.621046526745, 5454.4545545445535, 5461.563074954034, 5708.457696518824, 5766.481016708516, 5841.742431811362, 5868.970655146697, 5918.437748413894, 6144.324124346318, 6197.5351848611535, 6213.502919766408, 6215.34738852423, 6234.937650623481, 6364.109024736541, 6364.395382438707, 6367.0, 6374.171357723466, 6376.840578985516, 5900.291964964232, 5902.498287645555, 5909.852253693692, 5918.319393269786, 5927.792527261525, 6254.3745625438005, 6315.336889626615, 6376.744930202833, 6414.454771344394, 6444.645544495098, 5953.851153721192, 6020.729067191987, 6068.120122582201, 6158.107074474266, 6229.844253893689, 6262.467690246289, 6268.843278918063, 6278.623282603058, 6280.246370435577, 6296.622202667763, 6284.937150628527, 6295.087212354183, 6306.3378345274, 6309.747610095636, 6312.873742525216, 6103.246756470893, 6162.445379915829, 6245.250569931546, 6310.7791227306825, 6316.336784637547, 5159.406668233126, 5160.045391602565, 5173.5602473789395, 5173.71544565045, 5204.76578553966, 4402.053558484941, 4407.845725399659, 4414.580614841585, 4415.227335216325, 4463.4420697412825, 5372.811951581676, 5427.1045277528765, 5511.0, 5540.612157149041, 5576.219329293902, 6258.123862659231, 6312.210973628296, 6316.242050953915, 6316.368363163739, 6320.0, 5486.067368547357, 5492.395836457987, 5494.972525137428, 5500.092484739973, 5555.91659626369, 5391.514763671288, 5563.582731295088, 5587.32952045749, 5589.133684278943, 5591.944080559142, 6031.698415079229, 6071.605345652519, 6089.878202435926, 6131.54013449002, 6132.141500189888, 6298.149749783904, 6299.496040316672, 6302.621842689453, 6308.558400911892, 6330.113784070142, 6098.420650038417, 6100.145979562776, 6117.174181485442, 6132.141500189888, 6133.754649813957, 5986.700664966821, 6045.667488288186, 6129.114290130661, 6200.348963358782, 6229.408206220402, 6288.056791481315, 6335.366463353812, 6342.080398342307, 6345.206849143857, 6363.96818015907, 5963.821085367446, 6163.137160797402, 6168.19813424252, 6168.321484636776, 6172.537059720628, 5949.672767997802, 5963.314218864886, 5977.731002104829, 6131.529590167291, 6132.9386706134155, 6042.939570604238, 6068.575199736153, 6076.453119219292, 6107.328193898757, 6133.662648554372, 6071.150038994632, 6103.05402662588, 6122.571420000735, 6130.979101201984, 6171.84570385744, 6026.035834266497, 6042.546808989431, 6050.909236361546, 6075.149479072845, 6121.234845644294], "value": 5756.71472308855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.5131958948325, 750.4671683104996, 772.826114124322, 1132.6828488023345, 1146.403869987606, 36420.45369319462, 37435.43846842296, 37609.623903760956, 37614.43578346327, 37649.43525847108, 39377.40933885994, 39684.0, 39963.0, 39970.20059598806, 39998.0, 7224.3136901994485, 7340.082489688789, 7375.704971801135, 7446.441516886228, 7513.436492263075, 7374.151972523175, 7480.17718051014, 7480.8877866832045, 7482.363999060087, 7484.476086673935, 7381.29877661624, 7452.7391541296065, 7479.5886226257535, 7489.28851759082, 7490.550566966, 7407.111146662408, 7458.552486850806, 7462.626868656545, 7463.179050304462, 7469.439792015566, 7199.280071992759, 7232.783016509513, 7234.385077268438, 7236.529625574373, 7238.638068096574, 36147.819260903525, 36473.08817279563, 36520.269594608224, 36527.4520882187, 36544.0, 3361.0757041813454, 3394.2193295541915, 3398.0655319787256, 3399.6940275375086, 3405.6594340565994, 27852.303692407648, 27967.30081747952, 27989.86005069982, 28097.0, 28115.859420702767, 3414.829258537088, 3506.08841701157, 3516.9472457913153, 3517.6834084932225, 3547.8048707321086, 141559.0, 145221.0, 159403.2029839855, 167958.16020919816, 168913.0, 42837.14325713468, 43080.78459607682, 43100.353494696974, 43108.35337469941, 43190.0, 44584.55415445869, 44666.33000504995, 44827.32759008618, 44856.0, 45005.49945005473, 13860.722785544232, 14011.71976560463, 14027.579172624837, 14029.368678409292, 14030.789538156936, 11223.438828058564, 11244.100471962223, 11258.549658013751, 11270.887291126985, 11279.718007049889, 13073.411696473682, 13130.671733206555, 13145.474181032652, 13203.603891883258, 13361.398737056856, 5356.143017117242, 5376.435474275223, 5426.158945363475, 5454.3454785426, 5566.777328906879, 924.9260059195249, 926.7683079230193, 969.7478655549608, 974.7660561465198, 978.9363691360039, 23279.30162095106, 23435.7656423437, 23446.648300275167, 23543.41141471443, 23796.7620323798, 1046.2728403759465, 1060.3372891942536, 1061.5965932945585, 1075.7955988362187, 1089.1885545268826, 11789.823152652718, 11889.762204755856, 11913.28520288768, 12440.129190956546, 12488.81266780999, 212783.0, 214652.0, 214996.0, 215429.0, 216721.0, 47992.76003620029, 48203.0, 48216.758916205195, 48252.0, 48718.26922596164, 1355.7288542291383, 1400.3418393355107, 1409.4150927365233, 1425.836028856674, 1428.1645237536159, 20427.79572204259, 21221.78778212198, 22912.770872291065, 23003.65494517617, 23143.652845206998, 34532.136696582784, 34644.82677586596, 34836.303273933874, 34901.82549087238, 34923.82538087395, 171603.0, 171732.0, 171944.0, 172004.0, 172052.0, 32380.83809580937, 32683.346333072728, 32850.50724239186, 33496.80799476085, 33615.83192084024, 39560.40659390169, 40091.398629020005, 40239.396409054476, 40374.0, 40381.394279086424, 28109.71890281071, 28923.42153156883, 29464.410711786073, 29543.409131816814, 31292.374152516368, 29126.41747165087, 29271.268218294714, 29422.411551769274, 31008.534871976488, 31532.36935261236, 33239.501407479394, 33382.33235335328, 33990.15024624305, 34232.14419639529, 35347.82326088353, 28511.42977140404, 29366.265843354086, 30282.54576181315, 30838.229044273176, 31566.210844728146, 21588.89205553962, 23966.76033239715, 24089.51820963606, 24153.275401737978, 24205.0], "value": 15940.206648216266, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.4725427825245, 418.9410415968824, 429.1502824407673, 435.8692392282315, 438.92318844202237, 20093.497662558424, 20872.582548349023, 20957.58084838304, 21944.341669749934, 22782.65826012611, 22664.66003009952, 23213.18753843616, 23216.3035108947, 23248.76751232487, 23276.418089547726, 5929.614575052618, 6067.0, 6070.392960703938, 6070.514358851304, 6082.939170608303, 5760.798372056979, 5788.392218817026, 5804.448577385142, 5810.3027636683655, 5811.389804070575, 5776.306843178803, 5782.248307720011, 6018.8796224075495, 6046.032634778437, 6048.60684055535, 5888.764449422039, 5893.174955506232, 5915.763369465216, 5917.112433135021, 5925.05199168131, 5330.653507521999, 5335.946640533583, 5337.199420086979, 5354.357477102733, 5380.892382152335, 25125.12062077837, 25531.744682553122, 25735.485290294087, 25778.613320800203, 25778.87110564454, 1864.7296142059326, 1920.5294702797764, 1929.8552608554273, 1934.1199754111844, 1937.0702063009835, 16274.75587866183, 16781.734465847076, 16879.83120168807, 16934.745978810326, 16944.0, 2175.9564808703735, 2232.765559616233, 2242.3609271357586, 2243.069126312578, 2246.3373304874935, 107294.0, 109094.0, 112462.0, 115371.99999999916, 115381.0, 11811.88188118125, 11906.761864762657, 12017.0, 12031.458584363725, 12042.976347010426, 16884.0, 16939.23773430174, 17036.744448833277, 17055.91472042657, 17065.232064557124, 8597.828043439222, 8671.089535598798, 8766.0, 8936.24041956441, 9009.819803603892, 8395.916040839636, 8413.537255450887, 8553.315734741205, 8579.528125953133, 8634.568271586395, 7541.097591259002, 7602.277783610548, 7628.389728821681, 7692.615369231628, 7713.884291735629, 2081.1363284237173, 2092.4978005278927, 2107.4099252209407, 2139.8930053497575, 2299.7930186283315, 914.6798620482778, 946.7549774250575, 989.1641562879355, 994.8806143262855, 997.07272236819, 17982.2807087715, 18138.365157219436, 18751.624967500848, 18752.812471875106, 18975.90512047431, 940.3229674634252, 959.6833045095102, 970.2868391732071, 973.5813600152003, 1012.4380968562372, 10101.393916364894, 10146.543405546621, 10420.426876521864, 10642.0, 10902.781944361068, 409917.0, 418407.0, 431944.0, 434859.0, 437093.0, 94804.52597736967, 94974.52512737393, 95111.52444237872, 95985.0, 97693.51153244189, 1124.9775004499863, 1136.267107715519, 1201.5614300780153, 1211.2127117373777, 1218.6405010522094, 17539.386121485688, 18203.726944095586, 18215.726764098283, 19283.325083622007, 19848.70226946626, 46485.302720458545, 46951.29573056338, 48218.27672584844, 48487.0, 49572.50427495679, 56138.7193064032, 56418.435815641315, 59577.40422595719, 61088.69455652871, 61857.690711547955, 9987.550560224952, 10007.09936105754, 10045.899541004497, 10101.24240681937, 10113.14038306752, 16791.74812377791, 17269.56826079358, 17320.566985825455, 17471.82528174702, 17832.19755111049, 14404.207768572829, 14539.636509087357, 14569.125852448888, 14610.634734131307, 14672.26638668041, 13081.103240030332, 13230.0, 13316.796007510704, 13515.526956556474, 13879.514217002357, 14503.854961450672, 14856.0, 14929.104253744375, 14961.925190373979, 15017.17405542662, 9723.951380243054, 10125.139363154214, 10154.339967902062, 10168.694939151837, 10189.388636681822, 13677.658058548615, 13698.767110960061, 13793.931030344784, 13847.0, 13958.511452099128], "value": 10233.980671803878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.6475469245959, 1318.2683610596127, 1325.8077578751079, 1339.845917719462, 1342.583799022303, 10720.195985301094, 11251.493682784274, 11281.210315277924, 11296.830547541793, 11586.0, 11142.387168705718, 11329.0936725062, 11341.886581134186, 11358.886411135885, 11361.261518001324, 2243.5288589396205, 2305.700258966332, 2306.2965795432387, 2309.6766452696634, 2315.513742114158, 2243.4839986803045, 2310.7342655594653, 2312.838101332907, 2317.7102862142233, 2328.1036800831716, 2242.1703969531295, 2244.5623103494827, 2268.6370180771078, 2275.8065564427043, 2276.4536511237266, 2241.3051953894183, 2242.3273018094587, 2244.472548950995, 2247.4156719252946, 2257.1761307122947, 2211.1155537784853, 2219.411855858199, 2223.555288942218, 2226.944326391837, 2236.2508559632543, 10556.78886422275, 10661.946690266577, 10690.144788416908, 10709.625163119332, 10735.194860385502, 5887.0, 6106.145139680449, 6108.297545782248, 6109.755609775603, 6131.96934015327, 3490.458978858281, 3615.7649752765988, 3631.800250986195, 3641.253543023674, 3651.3427583035045, 1279.1301914698001, 1296.455488694741, 1331.8268625078774, 1336.866313368665, 1339.5981205638368, 15990.360385584563, 16193.757093643604, 16238.512844614681, 16367.0, 16561.66876662472, 4892.50482254053, 4902.7058376497525, 5017.3226614406585, 5040.647154699209, 5057.494250574987, 11555.76888462226, 11621.418929053683, 11624.186306958432, 11631.53473861053, 11679.649610511698, 6063.060225664941, 6163.660998645118, 6175.382461753788, 6175.413335733098, 6179.938200617937, 5716.714164291769, 5785.623934444247, 5801.9419805802245, 5802.303723553201, 5804.94195058044, 4147.605977432139, 4149.771762553029, 4219.810108545123, 4240.915181696349, 4256.659152366995, 1209.7580483903255, 1227.8035514317667, 1233.543588872123, 1260.6092111445482, 1264.2225031605496, 843.2242337049929, 860.9827803443897, 886.0, 894.6376717429322, 916.9449833010041, 6085.0, 6185.257769067741, 6370.299267080617, 6405.398650337415, 6488.708008139645, 608.2336256316984, 614.7510258345377, 618.35073173168, 620.6214209332304, 622.1942584353274, 4016.196760647882, 4058.228936502055, 4226.387173859773, 4701.318308845198, 4721.15019296523, 13649.317534123255, 14042.297885105909, 14082.788758168635, 14119.152850828983, 14134.434622615187, 13984.440622375194, 13989.901514772662, 14012.789808152886, 14085.929570352082, 14152.43390264378, 8445.57772111392, 8584.356173287028, 8760.386772925962, 8833.823323533494, 8834.690785822466, 6622.254405020517, 6665.733370665119, 6669.566478178903, 6898.271691149044, 7244.89132663, 12866.35668216604, 12969.35153242353, 13010.479580816662, 13185.011124165918, 13324.800127997894, 13080.0, 13182.80225796633, 13215.07494475416, 13295.268760217894, 13350.265735384648, 9240.815183696423, 9447.102525260088, 9458.716238512856, 9492.288078394286, 9497.335186537153, 10577.471126443801, 10938.835917461085, 11022.228444009163, 11028.889711103107, 11067.72330691739, 9071.863922041306, 9214.124658157465, 9259.166674999282, 9319.767005824908, 9462.621495140118, 8754.299656027375, 8986.955065224633, 9004.50475223869, 9024.684136055206, 9173.40372875761, 8067.515949043076, 8166.305864001389, 8195.426320157532, 8206.302464290602, 8232.382571307056, 6048.667323297261, 6253.562250642593, 6322.715477803418, 6363.236411630634, 6477.935220647922, 6268.558231606848, 6389.520785941166, 6517.674116294072, 6604.3725846044545, 6644.468442524683], "value": 5163.467891146482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.78755290813604, 395.6478733926805, 403.02669054234025, 404.45600667102747, 405.5376870367779, 6207.751689932408, 6382.808675584687, 6384.904226436607, 6421.903671444932, 6425.38958798914, 6067.211262535875, 6165.3834616538325, 6179.382061793818, 6181.320054793969, 6184.598001129923, 4820.542048505386, 4825.348577941985, 4829.9275510867365, 4834.7824347904425, 4836.250381190921, 4833.105875413043, 4837.274408838684, 4850.830220942268, 4858.684185527947, 4861.246506791453, 4767.475577686451, 4791.717673393737, 4799.160146974283, 4811.735354555498, 4813.951860481403, 4813.157697402958, 4826.107170173529, 4827.734474603895, 4833.734144622044, 4835.395575553056, 4199.601037901425, 4202.6847986400835, 4205.684573656988, 4217.683673724483, 4220.198162349144, 6140.83324168411, 6157.261128664589, 6162.661053642048, 6163.753449862, 6204.83553387771, 5520.972395138038, 5522.861928451781, 5524.58565607577, 5529.612927095105, 5534.4742249486235, 6558.114654521626, 6612.718612078825, 6628.171478565179, 6634.635095069769, 6637.336266373372, 4604.723716577016, 4606.585407313324, 4613.584777370019, 4616.584507394351, 4620.491745907947, 6578.210614726216, 6915.550489218235, 6970.30296970304, 6972.755953541652, 7064.258252883425, 4637.698549594265, 4664.370310008106, 4685.0, 4685.0, 4691.7654117294, 4641.512641172696, 4739.4075740532435, 4743.549362810528, 4745.193317136095, 4751.239801631722, 5280.234366016906, 5452.59105567084, 5490.0941344677685, 5524.116141417354, 5571.359293681197, 6586.835314142578, 6655.0, 6665.700043498055, 6676.365745254193, 6698.866022679616, 1604.767308740226, 1618.2313401134602, 1627.471071901613, 1633.428300094981, 1634.4687976407715, 1058.867641544807, 1101.7025403141106, 1104.3870651788175, 1106.5131342209402, 1113.3709454158375, 5800.332961709373, 5800.810833779065, 5856.736446859902, 5864.237649105589, 5898.262717160355, 6739.629320387426, 6794.93205067943, 6819.55672881271, 6858.5199036068, 6899.413549848218, 5779.306483222041, 5783.566232532577, 5796.565257605696, 5831.825045248649, 5849.61977471463, 3614.7288953328607, 3647.854085836537, 3660.871869484555, 3680.6135355787255, 3691.57546882112, 6635.668216589152, 6658.733650654017, 6673.899891501631, 6680.23177334603, 6687.431568316651, 6977.51157418986, 6990.161180658251, 7020.473464490082, 7029.859402811915, 7038.577685338793, 6591.307912669196, 6640.705062512764, 6650.501212409089, 6651.301613330627, 6658.1011563438315, 6801.047853300641, 6816.147981502312, 6824.249332573314, 6847.1783385994, 6865.794026179223, 6543.70553325111, 6795.218549866829, 6798.558093723892, 6804.183497980274, 6837.453003759787, 6200.596961197508, 6505.41451269388, 6568.7372505099265, 6580.894113883512, 6622.768203112868, 4672.813087476463, 4697.976510117427, 4699.475393454909, 4699.835505757282, 4721.858344249678, 6810.965945170243, 6817.216020157745, 6851.760188393382, 6853.5109503275435, 6861.2795656455355, 6406.9359306408205, 6630.635315057718, 6641.575824824001, 6678.365555272241, 6680.198376194693, 6597.6701164940605, 6617.371349721769, 6618.172728408949, 6624.801255962136, 6653.767118150841, 6540.444062254572, 6587.0, 6592.307807680125, 6598.449364399458, 6656.7004484797335, 6665.700043497957, 6703.430208432338, 6732.798016059526, 6745.190577130776, 6758.594484330956, 6376.74493020274, 6431.83920401975, 6462.515311351762, 6468.644224567505, 6503.739850405931], "value": 4968.618743529756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.6763159473021, 788.1724189600917, 813.4549851599428, 818.7666515043212, 837.5812093953022, 16547.42084027059, 17100.486985390442, 17125.0, 17804.91097544514, 19530.31643892464, 18339.816601833976, 18438.631227375477, 18690.71963920542, 18692.345767898125, 18697.90651046743, 945.2579724915943, 973.9707808765713, 980.289290264556, 983.0415345038601, 983.6557204978272, 954.9952250238774, 986.8470387090013, 999.9500024998757, 1003.4029752297372, 1005.2812239248935, 1033.8604288421043, 1039.064841642524, 1039.365986748083, 1039.3763741754924, 1039.9064084232418, 1034.0, 1034.0331789776546, 1035.8756949166072, 1036.1503567075001, 1037.2842738510442, 754.2156157596094, 754.5510421299318, 758.5221310574358, 758.6168984662766, 759.779663897469, 16156.434524791575, 17147.57131071721, 17286.222120004506, 17508.824911750846, 17533.123343832885, 18425.170867311004, 18492.07539623027, 18861.434156975174, 18873.811261887342, 18952.52618684544, 14403.855961440357, 14614.488492902803, 14625.926870365687, 14700.632484187874, 14701.926490367587, 3340.515625234327, 3383.796972181677, 3396.117009577503, 3412.4198886189406, 3418.077119177808, 97386.51306743492, 97730.51134744352, 97892.0, 97929.51035244849, 99927.50036249845, 14401.42394304216, 14688.853111468963, 14698.926505367619, 14975.550733478012, 14994.175320357484, 25819.483610327687, 26936.865315673294, 27198.45603087927, 27210.727892721214, 27243.0, 7565.092188937363, 7711.383089352838, 7770.961145194238, 7793.18171591986, 7838.568878711726, 3714.3685573452576, 3804.714646401531, 3805.37211360128, 3809.1810260794064, 3821.063839359375, 3850.961490385116, 3917.1578110706337, 3918.1771827916455, 3924.0778417071965, 4481.641468682497, 878.2490970220497, 895.8700988356782, 897.6804097975964, 898.6879156431553, 898.9572096368312, 661.256086902235, 669.9799006029826, 671.6171782084165, 675.76010516267, 676.9153855768029, 10410.531526081344, 11496.655100347003, 12146.574869879512, 12286.631401057983, 12416.75166496665, 645.5190882792256, 651.9217693876765, 658.4271683635268, 662.7084083003463, 681.7613835157655, 4649.232876575395, 5076.7207803571155, 5349.331333583302, 5416.2149854224235, 5810.535157187415, 89657.55171224102, 90753.54623226974, 91089.08910910938, 91125.0, 92448.53775731212, 80064.19935800684, 81494.59252703699, 81626.59186704029, 81664.0, 81765.0, 68015.0, 69842.0, 72178.0, 73408.63295683594, 73658.63170684219, 11553.0, 12475.93762031184, 12492.750144997231, 12583.496660133493, 12691.619251422471, 29322.853385732935, 29515.40969180647, 29814.0, 29847.552286716153, 30903.536446953764, 37733.24533509369, 37943.0, 38130.237395252494, 38212.808935955145, 39391.80304098461, 16621.916890415472, 16684.749728754323, 16975.915120424317, 17163.227654755814, 17589.0, 17856.821431785516, 18296.0, 18805.0, 19288.90355548213, 19575.510612234808, 16239.59401014984, 16475.17624118765, 17092.230849611547, 18263.0, 18609.16258768386, 16783.580410489834, 17811.821881781016, 18263.08684565793, 18669.43991680252, 19170.808291916903, 16832.495025148775, 17841.46475605734, 17924.462266132035, 18528.44414667562, 18550.81449185545, 11366.318020918441, 11879.643610691694, 11893.881061189277, 12137.817932731192, 12390.380480976095, 13064.693530646859, 13083.934580327037, 13136.540221092599, 14047.297635118408, 14195.503157389441], "value": 8204.886886217915, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 111.0, 108.0, 110.0, 111.0, 111.0, 109.0, 111.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 124.0, 167.0, 121.0, 121.0, 124.0, 121.0, 144.0, 121.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 163.0, 161.0, 164.0, 164.0, 169.0, 173.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 114.0, 73.0, 85.0, 76.0, 73.0, 93.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 105.0, 82.0, 82.0, 82.0, 93.0, 81.0, 82.0, 102.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 55.0, 55.0, 55.0, 56.0, 57.0, 59.0, 55.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 61.0, 55.0, 55.0, 55.0, 56.0, 57.0, 55.0, 57.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 86.0, 87.0, 86.0, 91.0, 89.0, 114.0, 90.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 129.0, 133.0, 131.0, 129.0, 134.0, 130.0, 130.0, 133.0, 147.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 189.0, 198.0, 206.0, 192.0, 206.0, 199.0, 196.0, 200.0, 195.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 71.0, 74.0, 71.0, 70.0, 71.0, 70.0, 73.0], "value": 72.2, "unit": "score"}]}]} 18:10:18 INFO - Return code: 0 18:10:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:10:18 INFO - # TBPL SUCCESS # 18:10:18 INFO - Running post-action listener: _resource_record_post_action 18:10:18 INFO - [mozharness: 2017-06-06 01:10:18.729676Z] Finished run-tests step (success) 18:10:18 INFO - Running post-run listener: _resource_record_post_run 18:10:18 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 8708096; Write bytes: 435191808; Read time: 2136; Write time: 290828 18:10:18 INFO - TinderboxPrint: CPU usage
12.7% 18:10:18 INFO - TinderboxPrint: I/O read bytes / time
8,708,096 / 2,136 18:10:18 INFO - TinderboxPrint: I/O write bytes / time
435,191,808 / 290,828 18:10:18 INFO - TinderboxPrint: CPU idle
8,739.9 (87.3%) 18:10:18 INFO - TinderboxPrint: CPU user
1,213.1 (12.1%) 18:10:18 INFO - TinderboxPrint: Swap in / out
0 / 0 18:10:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111599616; Read time: 0; Write time: 71652 18:10:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:10:18 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 6340608; Write bytes: 323592192; Read time: 1520; Write time: 219176 18:10:19 INFO - Running post-run listener: _upload_blobber_files 18:10:19 INFO - Blob upload gear active. 18:10:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:10:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:10:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:10:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:10:19 INFO - (blobuploader) - INFO - Open directory for files ... 18:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:10:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:20 INFO - (blobuploader) - INFO - Done attempting. 18:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:21 INFO - (blobuploader) - INFO - Done attempting. 18:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:10:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:27 INFO - (blobuploader) - INFO - Done attempting. 18:10:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:10:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:10:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:10:28 INFO - (blobuploader) - INFO - Done attempting. 18:10:28 INFO - (blobuploader) - INFO - Iteration through files over. 18:10:28 INFO - Return code: 0 18:10:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:10:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:10:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3863ca106a1786a054164481e836142f7ed7c56c008f4a711cb18dd4c89f3fff8c6b9189ac48bcd094beaecd8a8cc8dc8ac31bfbdfe0b13aa7cfdc392b3993dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86cad4cd083dd3e17d365cb209b6f1a8fe604ebf95ad630d5dc7f949f75b803d9dadcfb2901b1e80087f88ffc54f6760277da4344e76f18258c4a62d31a7ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0a6bd9bb10471283336e4958a362c4f34a7572cefe7e9b5c171a1eb458e717773359062d964b78cf80d1e5170ab1d80eda28f377e97b466264933bed49809d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c9d89c0de49fce4d98e1b360a7571ade2a6a8297be0ab3d713ccd1f16d213851994408b5cb35a02245e52c90aa40504a9c7b75eb48967cd731c923694308db4"} 18:10:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:10:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:10:28 INFO - Contents: 18:10:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3863ca106a1786a054164481e836142f7ed7c56c008f4a711cb18dd4c89f3fff8c6b9189ac48bcd094beaecd8a8cc8dc8ac31bfbdfe0b13aa7cfdc392b3993dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86cad4cd083dd3e17d365cb209b6f1a8fe604ebf95ad630d5dc7f949f75b803d9dadcfb2901b1e80087f88ffc54f6760277da4344e76f18258c4a62d31a7ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0a6bd9bb10471283336e4958a362c4f34a7572cefe7e9b5c171a1eb458e717773359062d964b78cf80d1e5170ab1d80eda28f377e97b466264933bed49809d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c9d89c0de49fce4d98e1b360a7571ade2a6a8297be0ab3d713ccd1f16d213851994408b5cb35a02245e52c90aa40504a9c7b75eb48967cd731c923694308db4"} 18:10:28 INFO - Running post-run listener: copy_logs_to_upload_dir 18:10:28 INFO - Copying logs to upload dir... 18:10:28 INFO - mkdir: /builds/slave/test/build/upload/logs 18:10:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.929570 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-05 18:10:28.775989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 18:10:28.780118) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3863ca106a1786a054164481e836142f7ed7c56c008f4a711cb18dd4c89f3fff8c6b9189ac48bcd094beaecd8a8cc8dc8ac31bfbdfe0b13aa7cfdc392b3993dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86cad4cd083dd3e17d365cb209b6f1a8fe604ebf95ad630d5dc7f949f75b803d9dadcfb2901b1e80087f88ffc54f6760277da4344e76f18258c4a62d31a7ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0a6bd9bb10471283336e4958a362c4f34a7572cefe7e9b5c171a1eb458e717773359062d964b78cf80d1e5170ab1d80eda28f377e97b466264933bed49809d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c9d89c0de49fce4d98e1b360a7571ade2a6a8297be0ab3d713ccd1f16d213851994408b5cb35a02245e52c90aa40504a9c7b75eb48967cd731c923694308db4"} build_url:https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011070 build_url: 'https://queue.taskcluster.net/v1/task/d1UkrHjKRd2sW85l0wKq-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3863ca106a1786a054164481e836142f7ed7c56c008f4a711cb18dd4c89f3fff8c6b9189ac48bcd094beaecd8a8cc8dc8ac31bfbdfe0b13aa7cfdc392b3993dc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86cad4cd083dd3e17d365cb209b6f1a8fe604ebf95ad630d5dc7f949f75b803d9dadcfb2901b1e80087f88ffc54f6760277da4344e76f18258c4a62d31a7ad6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b0a6bd9bb10471283336e4958a362c4f34a7572cefe7e9b5c171a1eb458e717773359062d964b78cf80d1e5170ab1d80eda28f377e97b466264933bed49809d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c9d89c0de49fce4d98e1b360a7571ade2a6a8297be0ab3d713ccd1f16d213851994408b5cb35a02245e52c90aa40504a9c7b75eb48967cd731c923694308db4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 18:10:28.805140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 18:10:28.805518) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1496707373.271903-990076500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 18:10:28.891439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 18:10:28.892322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 18:10:28.893303) ========= ========= Total master_lag: 0.20 =========