builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1496655215.31 results: success (0) revision: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.306152) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.306692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.306966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.325545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.325850) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 02:33:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.4M=0.001s 2017-06-05 02:33:36 (21.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104445 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.443518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.443843) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016972 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:35.493637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:33:35.493992) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 --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 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 --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=8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 02:33:36,848 truncating revision to first 12 chars 2017-06-05 02:33:36,848 Setting DEBUG logging. 2017-06-05 02:33:36,848 attempt 1/10 2017-06-05 02:33:36,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d5df2dead2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 02:33:37,959 unpacking tar archive at: mozilla-central-7d5df2dead2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:33:36.926364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:36.926674) ========= script_repo_revision: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:36.927034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:36.927302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:33:36.934360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-05 02:33:36.934638) ========= /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=8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:33:38 INFO - MultiFileLogger online at 20170605 02:33:38 in /builds/slave/test 02:33:38 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 02:33:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:33:38 INFO - {'append_to_log': False, 02:33:38 INFO - 'base_work_dir': '/builds/slave/test', 02:33:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:33:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:33:38 INFO - 'branch': 'Firefox-Non-PGO', 02:33:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:33:38 INFO - 'config_files': ('talos/linux_config.py',), 02:33:38 INFO - 'default_actions': ('clobber', 02:33:38 INFO - 'read-buildbot-config', 02:33:38 INFO - 'download-and-extract', 02:33:38 INFO - 'populate-webroot', 02:33:38 INFO - 'create-virtualenv', 02:33:38 INFO - 'install', 02:33:38 INFO - 'setup-mitmproxy', 02:33:38 INFO - 'run-tests'), 02:33:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:33:38 INFO - 'download_minidump_stackwalk': True, 02:33:38 INFO - 'download_symbols': 'ondemand', 02:33:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:33:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:33:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:33:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:33:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:33:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:33:38 INFO - 'gecko_profile': False, 02:33:38 INFO - 'gecko_profile_interval': 0, 02:33:38 INFO - 'installer_path': 'installer.exe', 02:33:38 INFO - 'log_level': 'info', 02:33:38 INFO - 'log_name': 'talos', 02:33:38 INFO - 'log_to_console': True, 02:33:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:33:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:33:38 INFO - 'opt_config_files': (), 02:33:38 INFO - 'pip_index': False, 02:33:38 INFO - 'suite': 'dromaeojs-e10s', 02:33:38 INFO - 'system_bits': '32', 02:33:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:33:38 INFO - 'title': 'talos-linux64-ix-089', 02:33:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:33:38 INFO - 'use_talos_json': True, 02:33:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:33:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:33:38 INFO - 'work_dir': 'build'} 02:33:38 INFO - [mozharness: 2017-06-05 09:33:38.395111Z] Running clobber step. 02:33:38 INFO - Running pre-action listener: _resource_record_pre_action 02:33:38 INFO - Running main action method: clobber 02:33:38 INFO - rmtree: /builds/slave/test/build 02:33:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:33:39 INFO - Running post-action listener: _resource_record_post_action 02:33:39 INFO - [mozharness: 2017-06-05 09:33:39.413713Z] Finished clobber step (success) 02:33:39 INFO - [mozharness: 2017-06-05 09:33:39.413813Z] Running read-buildbot-config step. 02:33:39 INFO - Running pre-action listener: _resource_record_pre_action 02:33:39 INFO - Running main action method: read_buildbot_config 02:33:39 INFO - Using buildbot properties: 02:33:39 INFO - { 02:33:39 INFO - "project": "", 02:33:39 INFO - "product": "firefox", 02:33:39 INFO - "who": "archaeopteryx@coole-files.de", 02:33:39 INFO - "installer_path": "public/build/target.tar.bz2", 02:33:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:33:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:33:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:33:39 INFO - "stage_platform": "linux64", 02:33:39 INFO - "basedir": "/builds/slave/test", 02:33:39 INFO - "buildnumber": 931, 02:33:39 INFO - "platform": "ubuntu64_hw", 02:33:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:33:39 INFO - "slavebuilddir": "test", 02:33:39 INFO - "taskId": "CDs5siajTeaSdiBopSKVzQ", 02:33:39 INFO - "branch": "mozilla-central", 02:33:39 INFO - "script_repo_revision": "production", 02:33:39 INFO - "revision": "7d5df2dead2c9edaa41688a82d9d9dcc86529ef2", 02:33:39 INFO - "slavename": "talos-linux64-ix-089", 02:33:39 INFO - "repo_path": "mozilla-central" 02:33:39 INFO - } 02:33:39 INFO - Finding installer, test and symbols from parent task. 02:33:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CDs5siajTeaSdiBopSKVzQ'}, attempt #1 02:33:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CDs5siajTeaSdiBopSKVzQ'}, attempt #1 02:33:40 INFO - Task dependencies: YIj7ffE3QgOo8lwBgNwUag 02:33:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag'}, attempt #1 02:33:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2 02:33:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/test_packages.json 02:33:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.crashreporter-symbols.zip 02:33:40 INFO - Running post-action listener: _resource_record_post_action 02:33:40 INFO - [mozharness: 2017-06-05 09:33:40.839893Z] Finished read-buildbot-config step (success) 02:33:40 INFO - [mozharness: 2017-06-05 09:33:40.840112Z] Running download-and-extract step. 02:33:40 INFO - Running pre-action listener: _resource_record_pre_action 02:33:40 INFO - Running main action method: download_and_extract 02:33:40 INFO - mkdir: /builds/slave/test/build/tests 02:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:33:40 INFO - trying https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.test_packages.json 02:33:40 INFO - Downloading https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:33:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:33:41 INFO - Downloaded 989 bytes. 02:33:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:33:41 INFO - Using the following test package requirements: 02:33:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:33:41 INFO - u'common': [u'target.common.tests.zip'], 02:33:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:33:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:33:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:33:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:33:41 INFO - u'mozbase': [u'target.common.tests.zip'], 02:33:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:33:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:33:41 INFO - u'web-platform': [u'target.common.tests.zip', 02:33:41 INFO - u'target.web-platform.tests.tar.gz'], 02:33:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:33:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:33:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.common.tests.zip 02:33:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:33:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.common.tests.zip into memory 02:33:42 INFO - Content-Length response header: 65102528 02:33:42 INFO - Bytes received: 65102528 02:33:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:33:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.common.tests.zip 02:33:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:33:53 INFO - Fetch https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.common.tests.zip into memory 02:33:54 INFO - Content-Length response header: 65102528 02:33:54 INFO - Bytes received: 65102528 02:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.talos.tests.zip 02:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:34:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.talos.tests.zip into memory 02:34:06 INFO - Content-Length response header: 14447425 02:34:06 INFO - Bytes received: 14447425 02:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:06 INFO - trying https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2 02:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:34:07 INFO - Downloaded 58527678 bytes. 02:34:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2 02:34:07 INFO - mkdir: /builds/slave/test/properties 02:34:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:34:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:34:07 INFO - Contents: 02:34:07 INFO - build_url:https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2 02:34:07 INFO - Running post-action listener: _resource_record_post_action 02:34:07 INFO - Running post-action listener: set_extra_try_arguments 02:34:07 INFO - [mozharness: 2017-06-05 09:34:07.916888Z] Finished download-and-extract step (success) 02:34:07 INFO - [mozharness: 2017-06-05 09:34:07.916983Z] Running populate-webroot step. 02:34:07 INFO - Running pre-action listener: _resource_record_pre_action 02:34:07 INFO - Running main action method: populate_webroot 02:34:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:34:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:34:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:34:07 INFO - '--tppagecycles', 02:34:07 INFO - '7'], 02:34:07 INFO - 'tests': ['tsvgm']}}, 02:34:07 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:34:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:34:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:34:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['damp', 'tps']}, 02:34:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'tests': ['damp', 'tps']}, 02:34:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['dromaeo_dom']}, 02:34:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:34:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:34:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:34:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:34:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['a11yr', 02:34:07 INFO - 'ts_paint', 02:34:07 INFO - 'tpaint', 02:34:07 INFO - 'sessionrestore', 02:34:07 INFO - 'sessionrestore_no_auto_restore', 02:34:07 INFO - 'tabpaint']}, 02:34:07 INFO - 'other-e10s': {'tests': ['a11yr', 02:34:07 INFO - 'ts_paint', 02:34:07 INFO - 'tpaint', 02:34:07 INFO - 'sessionrestore', 02:34:07 INFO - 'sessionrestore_no_auto_restore', 02:34:07 INFO - 'tabpaint']}, 02:34:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:34:07 INFO - 'ts_paint', 02:34:07 INFO - 'tpaint', 02:34:07 INFO - 'sessionrestore', 02:34:07 INFO - 'sessionrestore_no_auto_restore', 02:34:07 INFO - 'tabpaint']}, 02:34:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:34:07 INFO - 'ts_paint', 02:34:07 INFO - 'tpaint', 02:34:07 INFO - 'sessionrestore', 02:34:07 INFO - 'sessionrestore_no_auto_restore', 02:34:07 INFO - 'tabpaint']}, 02:34:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['a11yr', 02:34:07 INFO - 'ts_paint', 02:34:07 INFO - 'tpaint', 02:34:07 INFO - 'sessionrestore', 02:34:07 INFO - 'sessionrestore_no_auto_restore', 02:34:07 INFO - 'tabpaint']}, 02:34:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['a11yr', 02:34:07 INFO - 'ts_paint', 02:34:07 INFO - 'tpaint', 02:34:07 INFO - 'sessionrestore', 02:34:07 INFO - 'sessionrestore_no_auto_restore', 02:34:07 INFO - 'tabpaint']}, 02:34:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:34:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:34:07 INFO - 'bloom_basic_ref']}, 02:34:07 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:34:07 INFO - 'talos_options': ['--mitmproxy', 02:34:07 INFO - 'mitmproxy-recording-1.mp', 02:34:07 INFO - '--firstNonBlankPaint'], 02:34:07 INFO - 'tests': ['Quantum_1']}, 02:34:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['tsvgx', 02:34:07 INFO - 'tsvgr_opacity', 02:34:07 INFO - 'tart', 02:34:07 INFO - 'tscrollx', 02:34:07 INFO - 'cart', 02:34:07 INFO - 'tsvg_static']}, 02:34:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:34:07 INFO - 'tsvgr_opacity', 02:34:07 INFO - 'tart', 02:34:07 INFO - 'tscrollx', 02:34:07 INFO - 'cart', 02:34:07 INFO - 'tsvg_static']}, 02:34:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'talos_options': ['--disable-e10s'], 02:34:07 INFO - 'tests': ['tp5o']}, 02:34:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:34:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'talos_options': ['--disable-e10s', 02:34:07 INFO - '--xperf_path', 02:34:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:07 INFO - 'tests': ['tp5n']}, 02:34:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:34:07 INFO - 'talos_options': ['--xperf_path', 02:34:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:07 INFO - 'tests': ['tp5n']}}, 02:34:07 INFO - 'talos.zip': {'path': '', 02:34:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:34:07 INFO - Running post-action listener: _resource_record_post_action 02:34:07 INFO - [mozharness: 2017-06-05 09:34:07.931317Z] Finished populate-webroot step (success) 02:34:07 INFO - [mozharness: 2017-06-05 09:34:07.931411Z] Running create-virtualenv step. 02:34:07 INFO - Running pre-action listener: _resource_record_pre_action 02:34:07 INFO - Running main action method: create_virtualenv 02:34:07 INFO - Creating virtualenv /builds/slave/test/build/venv 02:34:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:34:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:34:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:34:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:34:08 INFO - Using real prefix '/usr' 02:34:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:34:08 INFO - Installing distribute.............................................................................................................................................................................................done. 02:34:10 INFO - Installing pip.................done. 02:34:10 INFO - Return code: 0 02:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:34:10 INFO - Reading from file tmpfile_stdout 02:34:10 INFO - Output received: 02:34:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:34:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:34:10 INFO - Using env: {'DISPLAY': ':0', 02:34:10 INFO - 'HOME': '/home/cltbld', 02:34:10 INFO - 'LANG': 'en_US.UTF-8', 02:34:10 INFO - 'LANGUAGE': 'en_US:en', 02:34:10 INFO - 'LOGNAME': 'cltbld', 02:34:10 INFO - 'MAIL': '/var/mail/cltbld', 02:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:10 INFO - 'MOZ_NO_REMOTE': '1', 02:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:10 INFO - 'NO_EM_RESTART': '1', 02:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:10 INFO - 'PWD': '/builds/slave/test', 02:34:10 INFO - 'SHELL': '/bin/bash', 02:34:10 INFO - 'SHLVL': '1', 02:34:10 INFO - 'TERM': 'linux', 02:34:10 INFO - 'TMOUT': '86400', 02:34:10 INFO - 'USER': 'cltbld', 02:34:10 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:10 INFO - '_': '/tools/buildbot/bin/python'} 02:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:34:10 INFO - Cleaning up... 02:34:10 INFO - Return code: 0 02:34:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:34:10 INFO - Using env: {'DISPLAY': ':0', 02:34:10 INFO - 'HOME': '/home/cltbld', 02:34:10 INFO - 'LANG': 'en_US.UTF-8', 02:34:10 INFO - 'LANGUAGE': 'en_US:en', 02:34:10 INFO - 'LOGNAME': 'cltbld', 02:34:10 INFO - 'MAIL': '/var/mail/cltbld', 02:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:10 INFO - 'MOZ_NO_REMOTE': '1', 02:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:10 INFO - 'NO_EM_RESTART': '1', 02:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:10 INFO - 'PWD': '/builds/slave/test', 02:34:10 INFO - 'SHELL': '/bin/bash', 02:34:10 INFO - 'SHLVL': '1', 02:34:10 INFO - 'TERM': 'linux', 02:34:10 INFO - 'TMOUT': '86400', 02:34:10 INFO - 'USER': 'cltbld', 02:34:10 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:10 INFO - '_': '/tools/buildbot/bin/python'} 02:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:11 INFO - Downloading/unpacking psutil>=3.1.1 02:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:12 INFO - Installing collected packages: psutil 02:34:12 INFO - Running setup.py install for psutil 02:34:12 INFO - building 'psutil._psutil_linux' extension 02:34:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:34:12 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 02:34:12 INFO - building 'psutil._psutil_posix' extension 02:34:12 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 02:34:12 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 02:34:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:12 INFO - Successfully installed psutil 02:34:12 INFO - Cleaning up... 02:34:12 INFO - Return code: 0 02:34:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:34: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 mozsystemmonitor==0.3 02:34:12 INFO - Using env: {'DISPLAY': ':0', 02:34:12 INFO - 'HOME': '/home/cltbld', 02:34:12 INFO - 'LANG': 'en_US.UTF-8', 02:34:12 INFO - 'LANGUAGE': 'en_US:en', 02:34:12 INFO - 'LOGNAME': 'cltbld', 02:34:12 INFO - 'MAIL': '/var/mail/cltbld', 02:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:12 INFO - 'MOZ_NO_REMOTE': '1', 02:34:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:12 INFO - 'NO_EM_RESTART': '1', 02:34:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:12 INFO - 'PWD': '/builds/slave/test', 02:34:12 INFO - 'SHELL': '/bin/bash', 02:34:12 INFO - 'SHLVL': '1', 02:34:12 INFO - 'TERM': 'linux', 02:34:12 INFO - 'TMOUT': '86400', 02:34:12 INFO - 'USER': 'cltbld', 02:34:12 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:12 INFO - '_': '/tools/buildbot/bin/python'} 02:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34: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 02:34: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 02:34: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 02:34: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 02:34:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:14 INFO - Installing collected packages: mozsystemmonitor 02:34:14 INFO - Running setup.py install for mozsystemmonitor 02:34:14 INFO - Successfully installed mozsystemmonitor 02:34:14 INFO - Cleaning up... 02:34:14 INFO - Return code: 0 02:34:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34: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', '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 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:34: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 jsonschema==2.5.1 02:34:14 INFO - Using env: {'DISPLAY': ':0', 02:34:14 INFO - 'HOME': '/home/cltbld', 02:34:14 INFO - 'LANG': 'en_US.UTF-8', 02:34:14 INFO - 'LANGUAGE': 'en_US:en', 02:34:14 INFO - 'LOGNAME': 'cltbld', 02:34:14 INFO - 'MAIL': '/var/mail/cltbld', 02:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:14 INFO - 'MOZ_NO_REMOTE': '1', 02:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:14 INFO - 'NO_EM_RESTART': '1', 02:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:14 INFO - 'PWD': '/builds/slave/test', 02:34:14 INFO - 'SHELL': '/bin/bash', 02:34:14 INFO - 'SHLVL': '1', 02:34:14 INFO - 'TERM': 'linux', 02:34:14 INFO - 'TMOUT': '86400', 02:34:14 INFO - 'USER': 'cltbld', 02:34:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:14 INFO - '_': '/tools/buildbot/bin/python'} 02:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:14 INFO - Downloading/unpacking jsonschema==2.5.1 02:34: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 02:34: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 02:34: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 02:34: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 02:34:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34: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 02:34: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 02:34: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 02:34: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 02:34:15 INFO - Downloading functools32-3.2.3-2.tar.gz 02:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:34:15 INFO - warning: no files found matching '*.txt' 02:34:15 INFO - no previously-included directories found matching 'build' 02:34:15 INFO - no previously-included directories found matching 'dist' 02:34:15 INFO - no previously-included directories found matching '.git*' 02:34:15 INFO - Installing collected packages: jsonschema, functools32 02:34:15 INFO - Running setup.py install for functools32 02:34:15 INFO - warning: no files found matching '*.txt' 02:34:15 INFO - no previously-included directories found matching 'build' 02:34:15 INFO - no previously-included directories found matching 'dist' 02:34:15 INFO - no previously-included directories found matching '.git*' 02:34:15 INFO - Successfully installed jsonschema functools32 02:34:15 INFO - Cleaning up... 02:34:16 INFO - Return code: 0 02:34:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:16 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 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:16 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 02:34:16 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 02:34:16 INFO - Using env: {'DISPLAY': ':0', 02:34:16 INFO - 'HOME': '/home/cltbld', 02:34:16 INFO - 'LANG': 'en_US.UTF-8', 02:34:16 INFO - 'LANGUAGE': 'en_US:en', 02:34:16 INFO - 'LOGNAME': 'cltbld', 02:34:16 INFO - 'MAIL': '/var/mail/cltbld', 02:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:16 INFO - 'MOZ_NO_REMOTE': '1', 02:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:16 INFO - 'NO_EM_RESTART': '1', 02:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:16 INFO - 'PWD': '/builds/slave/test', 02:34:16 INFO - 'SHELL': '/bin/bash', 02:34:16 INFO - 'SHLVL': '1', 02:34:16 INFO - 'TERM': 'linux', 02:34:16 INFO - 'TMOUT': '86400', 02:34:16 INFO - 'USER': 'cltbld', 02:34:16 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:16 INFO - '_': '/tools/buildbot/bin/python'} 02:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:34:16 INFO - Cleaning up... 02:34:16 INFO - Return code: 0 02:34:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:16 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 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:16 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 02:34:16 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 02:34:16 INFO - Using env: {'DISPLAY': ':0', 02:34:16 INFO - 'HOME': '/home/cltbld', 02:34:16 INFO - 'LANG': 'en_US.UTF-8', 02:34:16 INFO - 'LANGUAGE': 'en_US:en', 02:34:16 INFO - 'LOGNAME': 'cltbld', 02:34:16 INFO - 'MAIL': '/var/mail/cltbld', 02:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:16 INFO - 'MOZ_NO_REMOTE': '1', 02:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:16 INFO - 'NO_EM_RESTART': '1', 02:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:16 INFO - 'PWD': '/builds/slave/test', 02:34:16 INFO - 'SHELL': '/bin/bash', 02:34:16 INFO - 'SHLVL': '1', 02:34:16 INFO - 'TERM': 'linux', 02:34:16 INFO - 'TMOUT': '86400', 02:34:16 INFO - 'USER': 'cltbld', 02:34:16 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:16 INFO - '_': '/tools/buildbot/bin/python'} 02:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:16 INFO - Downloading/unpacking blobuploader==1.2.4 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:34:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:18 INFO - Downloading docopt-0.6.1.tar.gz 02:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:34:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:34:18 INFO - Running setup.py install for blobuploader 02:34:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:34:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:34:18 INFO - Running setup.py install for requests 02:34:18 INFO - Running setup.py install for docopt 02:34:18 INFO - Successfully installed blobuploader requests docopt 02:34:18 INFO - Cleaning up... 02:34:18 INFO - Return code: 0 02:34:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:18 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')]} 02:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:18 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')]} 02:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:18 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 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:18 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 02:34:18 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 02:34:18 INFO - Using env: {'DISPLAY': ':0', 02:34:18 INFO - 'HOME': '/home/cltbld', 02:34:18 INFO - 'LANG': 'en_US.UTF-8', 02:34:18 INFO - 'LANGUAGE': 'en_US:en', 02:34:18 INFO - 'LOGNAME': 'cltbld', 02:34:18 INFO - 'MAIL': '/var/mail/cltbld', 02:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:18 INFO - 'MOZ_NO_REMOTE': '1', 02:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:18 INFO - 'NO_EM_RESTART': '1', 02:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:18 INFO - 'PWD': '/builds/slave/test', 02:34:18 INFO - 'SHELL': '/bin/bash', 02:34:18 INFO - 'SHLVL': '1', 02:34:18 INFO - 'TERM': 'linux', 02:34:18 INFO - 'TMOUT': '86400', 02:34:18 INFO - 'USER': 'cltbld', 02:34:18 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:18 INFO - '_': '/tools/buildbot/bin/python'} 02:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:18 INFO - Running setup.py (path:/tmp/pip-oy5T1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:19 INFO - Running setup.py (path:/tmp/pip-DpCxyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:19 INFO - Running setup.py (path:/tmp/pip-qOSXLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:19 INFO - Running setup.py (path:/tmp/pip-cBlTgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:19 INFO - Running setup.py (path:/tmp/pip-hPUy4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:19 INFO - Running setup.py (path:/tmp/pip-OFH4fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:19 INFO - Running setup.py (path:/tmp/pip-3N2G7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:19 INFO - Running setup.py (path:/tmp/pip-fO2h01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:19 INFO - Running setup.py (path:/tmp/pip-oIpr65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:19 INFO - Running setup.py (path:/tmp/pip-UkPsJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:19 INFO - Running setup.py (path:/tmp/pip-j4uZW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:19 INFO - Running setup.py (path:/tmp/pip-ALOMR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:19 INFO - Running setup.py (path:/tmp/pip-_HcFvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:19 INFO - Running setup.py (path:/tmp/pip-EppSA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:19 INFO - Running setup.py (path:/tmp/pip-tihuD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:20 INFO - Running setup.py (path:/tmp/pip-HejSFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:20 INFO - Running setup.py (path:/tmp/pip-PqRfmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:20 INFO - Running setup.py install for manifestparser 02:34:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozcrash 02:34:20 INFO - Running setup.py install for mozdebug 02:34:20 INFO - Running setup.py install for mozdevice 02:34:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozfile 02:34:20 INFO - Running setup.py install for mozhttpd 02:34:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozinfo 02:34:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozInstall 02:34:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:20 INFO - Running setup.py install for mozleak 02:34:21 INFO - Running setup.py install for mozlog 02:34:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Running setup.py install for moznetwork 02:34:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Running setup.py install for mozprocess 02:34:21 INFO - Running setup.py install for mozprofile 02:34:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Running setup.py install for mozrunner 02:34:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Running setup.py install for mozscreenshot 02:34:21 INFO - Running setup.py install for moztest 02:34:21 INFO - Running setup.py install for mozversion 02:34:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:21 INFO - Cleaning up... 02:34:21 INFO - Return code: 0 02:34:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:21 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')]} 02:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:21 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')]} 02:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:21 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 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:21 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 02:34:21 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 02:34:21 INFO - Using env: {'DISPLAY': ':0', 02:34:21 INFO - 'HOME': '/home/cltbld', 02:34:21 INFO - 'LANG': 'en_US.UTF-8', 02:34:21 INFO - 'LANGUAGE': 'en_US:en', 02:34:21 INFO - 'LOGNAME': 'cltbld', 02:34:21 INFO - 'MAIL': '/var/mail/cltbld', 02:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:21 INFO - 'MOZ_NO_REMOTE': '1', 02:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:21 INFO - 'NO_EM_RESTART': '1', 02:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:21 INFO - 'PWD': '/builds/slave/test', 02:34:21 INFO - 'SHELL': '/bin/bash', 02:34:21 INFO - 'SHLVL': '1', 02:34:21 INFO - 'TERM': 'linux', 02:34:21 INFO - 'TMOUT': '86400', 02:34:21 INFO - 'USER': 'cltbld', 02:34:21 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:21 INFO - '_': '/tools/buildbot/bin/python'} 02:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:22 INFO - Running setup.py (path:/tmp/pip-qaT9P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:22 INFO - Running setup.py (path:/tmp/pip-43kQqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:22 INFO - Running setup.py (path:/tmp/pip-OiGs26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:22 INFO - Running setup.py (path:/tmp/pip-JjyuyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:22 INFO - Running setup.py (path:/tmp/pip-Zi8yB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:22 INFO - Running setup.py (path:/tmp/pip-qPW0Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:22 INFO - Running setup.py (path:/tmp/pip-SckjKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:22 INFO - Running setup.py (path:/tmp/pip-Di2kEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:22 INFO - Running setup.py (path:/tmp/pip-VWxaU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:22 INFO - Running setup.py (path:/tmp/pip-9JSNsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:22 INFO - Running setup.py (path:/tmp/pip-AguINn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:22 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)) 02:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:22 INFO - Running setup.py (path:/tmp/pip-qBAaOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:23 INFO - Running setup.py (path:/tmp/pip-W99lbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:23 INFO - Running setup.py (path:/tmp/pip-tCWIh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:23 INFO - Running setup.py (path:/tmp/pip-66zx6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:23 INFO - Running setup.py (path:/tmp/pip-hknZrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:23 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)) 02:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:23 INFO - Running setup.py (path:/tmp/pip-8yYJws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:23 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)) 02:34:23 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)) 02:34:23 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)) 02:34:23 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)) 02:34:23 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)) 02:34:23 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)) 02:34:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:34:23 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 02:34:23 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 02:34:23 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 02:34:23 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 02:34:24 INFO - Downloading blessings-1.6.tar.gz 02:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:34:24 INFO - Installing collected packages: blessings 02:34:24 INFO - Running setup.py install for blessings 02:34:24 INFO - Successfully installed blessings 02:34:24 INFO - Cleaning up... 02:34:24 INFO - Return code: 0 02:34:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:24 INFO - Reading from file tmpfile_stdout 02:34:24 INFO - Current package versions: 02:34:24 INFO - argparse == 1.2.1 02:34:24 INFO - blessings == 1.6 02:34:24 INFO - blobuploader == 1.2.4 02:34:24 INFO - docopt == 0.6.1 02:34:24 INFO - functools32 == 3.2.3-2 02:34:24 INFO - jsonschema == 2.5.1 02:34:24 INFO - manifestparser == 1.1 02:34:24 INFO - mozInstall == 1.12 02:34:24 INFO - mozcrash == 1.0 02:34:24 INFO - mozdebug == 0.1 02:34:24 INFO - mozdevice == 0.51 02:34:24 INFO - mozfile == 1.2 02:34:24 INFO - mozhttpd == 0.7 02:34:24 INFO - mozinfo == 0.9 02:34:24 INFO - mozleak == 0.1 02:34:24 INFO - mozlog == 3.4 02:34:24 INFO - moznetwork == 0.27 02:34:24 INFO - mozprocess == 0.25 02:34:24 INFO - mozprofile == 0.28 02:34:24 INFO - mozrunner == 6.13 02:34:24 INFO - mozscreenshot == 0.1 02:34:24 INFO - mozsystemmonitor == 0.3 02:34:24 INFO - moztest == 0.8 02:34:24 INFO - mozversion == 1.4 02:34:24 INFO - psutil == 3.1.1 02:34:24 INFO - requests == 1.2.3 02:34:24 INFO - wsgiref == 0.1.2 02:34:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34: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')]} 02:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34: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')]} 02:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:24 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 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:24 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 02:34:24 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 02:34:24 INFO - Using env: {'DISPLAY': ':0', 02:34:24 INFO - 'HOME': '/home/cltbld', 02:34:24 INFO - 'LANG': 'en_US.UTF-8', 02:34:24 INFO - 'LANGUAGE': 'en_US:en', 02:34:24 INFO - 'LOGNAME': 'cltbld', 02:34:24 INFO - 'MAIL': '/var/mail/cltbld', 02:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:24 INFO - 'MOZ_NO_REMOTE': '1', 02:34:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:24 INFO - 'NO_EM_RESTART': '1', 02:34:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:24 INFO - 'PWD': '/builds/slave/test', 02:34:24 INFO - 'SHELL': '/bin/bash', 02:34:24 INFO - 'SHLVL': '1', 02:34:24 INFO - 'TERM': 'linux', 02:34:24 INFO - 'TMOUT': '86400', 02:34:24 INFO - 'USER': 'cltbld', 02:34:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:24 INFO - '_': '/tools/buildbot/bin/python'} 02:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 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)) 02:34:25 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:34:25 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 02:34:25 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 02:34:25 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 02:34:25 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 02:34:26 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:34:26 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)) 02:34:26 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)) 02:34:26 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)) 02:34:26 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)) 02:34:26 INFO - Installing collected packages: marionette-driver 02:34:26 INFO - Running setup.py install for marionette-driver 02:34:26 INFO - Successfully installed marionette-driver 02:34:26 INFO - Cleaning up... 02:34:26 INFO - Return code: 0 02:34:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x219d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2377a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x251bdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', '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 02:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:34:26 INFO - Using env: {'DISPLAY': ':0', 02:34:26 INFO - 'HOME': '/home/cltbld', 02:34:26 INFO - 'LANG': 'en_US.UTF-8', 02:34:26 INFO - 'LANGUAGE': 'en_US:en', 02:34:26 INFO - 'LOGNAME': 'cltbld', 02:34:26 INFO - 'MAIL': '/var/mail/cltbld', 02:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:26 INFO - 'MOZ_NO_REMOTE': '1', 02:34:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:26 INFO - 'NO_EM_RESTART': '1', 02:34:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:26 INFO - 'PWD': '/builds/slave/test', 02:34:26 INFO - 'SHELL': '/bin/bash', 02:34:26 INFO - 'SHLVL': '1', 02:34:26 INFO - 'TERM': 'linux', 02:34:26 INFO - 'TMOUT': '86400', 02:34:26 INFO - 'USER': 'cltbld', 02:34:26 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:26 INFO - '_': '/tools/buildbot/bin/python'} 02:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:34:26 INFO - Cleaning up... 02:34:26 INFO - Return code: 0 02:34:26 INFO - Running post-action listener: _resource_record_post_action 02:34:26 INFO - Running post-action listener: _start_resource_monitoring 02:34:26 INFO - Starting resource monitoring. 02:34:26 INFO - [mozharness: 2017-06-05 09:34:26.732964Z] Finished create-virtualenv step (success) 02:34:26 INFO - [mozharness: 2017-06-05 09:34:26.733427Z] Running install step. 02:34:26 INFO - Running pre-action listener: _resource_record_pre_action 02:34:26 INFO - Running main action method: install 02:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:34:26 INFO - Reading from file tmpfile_stdout 02:34:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:34:27 INFO - Reading from file tmpfile_stdout 02:34:27 INFO - Output received: 02:34:27 INFO - Usage: mozinstall [options] installer 02:34:27 INFO - Options: 02:34:27 INFO - -h, --help show this help message and exit 02:34:27 INFO - -d DEST, --destination=DEST 02:34:27 INFO - Directory to install application into. [default: 02:34:27 INFO - "/builds/slave/test"] 02:34:27 INFO - --app=APP Application being installed. [default: firefox] 02:34:27 INFO - mkdir: /builds/slave/test/build/application 02:34:27 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'] 02:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:34:43 INFO - Reading from file tmpfile_stdout 02:34:43 INFO - Output received: 02:34:43 INFO - /builds/slave/test/build/application/firefox/firefox 02:34:43 INFO - Running post-action listener: _resource_record_post_action 02:34:43 INFO - [mozharness: 2017-06-05 09:34:43.930035Z] Finished install step (success) 02:34:43 INFO - [mozharness: 2017-06-05 09:34:43.930180Z] Running setup-mitmproxy step. 02:34:43 INFO - Running pre-action listener: _resource_record_pre_action 02:34:43 INFO - Running main action method: setup_mitmproxy 02:34:43 INFO - Skipping: mitmproxy is not required 02:34:43 INFO - Running post-action listener: _resource_record_post_action 02:34:43 INFO - [mozharness: 2017-06-05 09:34:43.930990Z] Finished setup-mitmproxy step (success) 02:34:43 INFO - [mozharness: 2017-06-05 09:34:43.931208Z] Running run-tests step. 02:34:43 INFO - Running pre-action listener: _resource_record_pre_action 02:34:43 INFO - Running main action method: run_tests 02:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:34:43 INFO - Python 2.7.3 02:34:43 INFO - Return code: 0 02:34:43 INFO - grabbing minidump binary from tooltool 02:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:34:43 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 0x2518840>, '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 0x2519740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2519bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:34:43 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 02:34:43 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 02:34:43 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 02:34:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:34:44 INFO - Return code: 0 02:34:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:34:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:34:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:34:44 INFO - ENV: RUST_BACKTRACE is now 1 02:34:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:34:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:34:44 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/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 02:34:44 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/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 02:34:44 INFO - Using env: {'DISPLAY': ':0', 02:34:44 INFO - 'HOME': '/home/cltbld', 02:34:44 INFO - 'LANG': 'en_US.UTF-8', 02:34:44 INFO - 'LANGUAGE': 'en_US:en', 02:34:44 INFO - 'LOGNAME': 'cltbld', 02:34:44 INFO - 'MAIL': '/var/mail/cltbld', 02:34:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:34:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:44 INFO - 'MOZ_NO_REMOTE': '1', 02:34:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:34:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:44 INFO - 'NO_EM_RESTART': '1', 02:34:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:44 INFO - 'PWD': '/builds/slave/test', 02:34:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:34:44 INFO - 'RUST_BACKTRACE': '1', 02:34:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:34:44 INFO - 'SHELL': '/bin/bash', 02:34:44 INFO - 'SHLVL': '1', 02:34:44 INFO - 'TERM': 'linux', 02:34:44 INFO - 'TMOUT': '86400', 02:34:44 INFO - 'USER': 'cltbld', 02:34:44 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570', 02:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:44 INFO - '_': '/tools/buildbot/bin/python'} 02:34:44 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/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 02:34:44 INFO - mozversion application_buildid: 20170605090212 02:34:44 INFO - mozversion application_changeset: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 02:34:44 INFO - mozversion application_display_name: Nightly 02:34:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:34:44 INFO - mozversion application_name: Firefox 02:34:44 INFO - mozversion application_remotingname: firefox 02:34:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:34:44 INFO - mozversion application_vendor: Mozilla 02:34:44 INFO - mozversion application_version: 55.0a1 02:34:44 INFO - mozversion platform_buildid: 20170605090212 02:34:44 INFO - mozversion platform_changeset: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 02:34:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:34:44 INFO - mozversion platform_version: 55.0a1 02:34:44 INFO - using testdate: 1496655284 02:34:44 INFO - actual date: 1496655284 02:34:44 INFO - starting webserver on 'localhost:54717' 02:34:44 INFO - SUITE-START | Running 2 tests 02:34:44 INFO - TEST-START | dromaeo_css 02:34:44 INFO - operating with platform_type : linux_ 02:34:44 INFO - Initialising browser for dromaeo_css test... 02:34:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54717/getInfo.html -profile /tmp/tmpxb852z/profile 02:34:44 INFO - TEST-INFO | started process 1055 (/builds/slave/test/build/application/firefox/firefox http://localhost:54717/getInfo.html) 02:35:19 INFO - TEST-INFO | 1055: killed by SIGTERM 02:35:19 INFO - Browser initialized. 02:35:19 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:19 INFO - TEST-INFO | started process 1338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxb852z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:31 INFO - PID 1338 | RSS: Main: 188518400 02:35:31 INFO - PID 1338 | 02:38:32 INFO - PID 1338 | Cycle 1(1): loaded http://localhost:54717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54717/tests/dromaeo/cssquery-ext.html) 02:38:33 INFO - PID 1338 | RSS: Main: 185528320 02:38:33 INFO - PID 1338 | 02:41:35 INFO - PID 1338 | Cycle 1(1): loaded http://localhost:54717/tests/dromaeo/cssquery-ext.html (next: http://localhost:54717/tests/dromaeo/cssquery-jquery.html) 02:41:36 INFO - PID 1338 | RSS: Main: 189149184 02:41:36 INFO - PID 1338 | 02:44:37 INFO - PID 1338 | Cycle 1(1): loaded http://localhost:54717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54717/tests/dromaeo/cssquery-mootools.html) 02:44:38 INFO - PID 1338 | RSS: Main: 186601472 02:44:38 INFO - PID 1338 | 02:47:40 INFO - PID 1338 | Cycle 1(1): loaded http://localhost:54717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54717/tests/dromaeo/cssquery-prototype.html) 02:47:40 INFO - PID 1338 | RSS: Main: 191827968 02:47:40 INFO - PID 1338 | 02:50:43 INFO - PID 1338 | Cycle 1(1): loaded http://localhost:54717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54717/tests/dromaeo/cssquery-yui.html) 02:50:43 INFO - PID 1338 | RSS: Main: 189067264 02:50:43 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | Cycle 1(1): loaded http://localhost:54717/tests/dromaeo/cssquery-yui.html (next: http://localhost:54717/tests/dromaeo/cssquery-dojo.html) 02:53:45 INFO - PID 1338 | RSS: Main: 188350464 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | __start_tp_report 02:53:45 INFO - PID 1338 | _x_x_mozilla_page_load 02:53:45 INFO - PID 1338 | _x_x_mozilla_page_load_details 02:53:45 INFO - PID 1338 | |i|pagename|runs| 02:53:45 INFO - PID 1338 | |0;dojo.html;3155.258514249151;3162.8892988745383;3165.1612322734463;3191.409589225992;3191.904242872714;5859.091840764689;6022.75908963642;6035.909461358083;6070.969645151774;6072.119542666316;6073.119397687333;6077.24034495688;6112.235970503687;6118.984682626211;6137.31569828693;5466.808661696841;5600.355959064698;5603.943960560403;5609.663420194802;5655.915161272585;5670.68811215383;5679.290088738908;5682.687452190128;5690.971545142289;5694.829155125353;5442.047641662693;5485.807996720136;5494.945050549483;5565;5592.496675299242;5559.972200139014;5593.496585307301;5615.410381909882;5633.57748168889;5652.208690783294;5562.972185139089;5567.888642227133;5574.637648552872;5575.69333686647;5614.214010038598;5895.823125306248;5960.04639257721;6018;6036.185115009462;6095.481884039862;6371.96814015927;6534.836629084263;6555.737770489175;6567.934320656828;6574.309697481744;6633.4029937305395;6646.26891041985;6650.135482387307;6650.135482387307;6653.101831252768;6006.279246490449;6140.785072522441;6141.692915354214;6141.692915354214;6146.569740118149;6620.3710647488415;6668.333166683293;6688.398044176048;6752.966235168793;6784.3894049535775;6271.498280137578;6280.591761535577;6348.809535713936;6426.132472116298;6427.967860160669;6575.112359831457;6580.901286480706;6590.3080176581725;6594.472442204612;6600.60396376219;6303.2751233607805;6517.771877984248;6532.314107018789;6543.672816359163;6555.737770489222;6400.103985442041;6428.164338635947;6503.577267477599;6507.642079685663;6546.410823025855;5363.19552067193;5364.597655175878;5368.194770784414;5371.704556249444;5405.675659460445;4548.204064288736;4554.453465584085;4567.703099298535;4569.040501494657;4603.079384123189;5594.356648985337;5664.065429204217;5666.914996275059;5721.5136713379;5744.396838331999;6523.902141467882;6543.607383556907;6544.411003009657;6547.639879806657;6548.738050478023;5676.602637815396;5678.801241956594;5688.089905615082;5700.287464066992;5733.713314334266;5709.514691251207;5734.942650573525;5786.652800831879;5791.8552036199435;5804.622699524517;6208.4722798562625;6286.151369565142;6289.591176573508;6299.181106456132;6318.747250109944;6550.7707230246715;6558.409743123142;6575.375339342755;6576.967115164393;6578.046183303299;6312.5265605078885;6330.588511746721;6410.102585637921;6410.743570257324;6414.743410263537;6164.321924588202;6208.503319734501;6387.584806987531;6424.51816113784;6443.581167224115;6547.181602299713;6576.8355791105605;6580.605163690194;6595.340465953558;6600.075989361397;6205.131281620667;6249.843753906007;6306.779262725966;6373.298937117006;6403.039544068427;6319.273283572448;6404.039394090737;6410.8076757697345;6414.647194404352;6420.486361091195;6119.289302195972;6271.811845644638;6342.39747224013;6348.238211414659;6359.841003974752;6335.968320158369;6370.904436433365;6395.16862807832;6412.1343618612755;6446.967765161145;6281.466075383643;6284.214473190851;6306.054091886253;6310.085037669421;6315 02:53:45 INFO - PID 1338 | |1;ext.html;724.7246046502328;766.0462723908734;786.1509569664761;1119.5857532712898;1138.1577632551903;35828;36781.264374712526;36833.815830920874;36848;36851.262974740486;38064.80967595165;38265.617343826554;38515.42226866599;38620.22759544807;38656.42015369772;7319.524230925;7446.255374462551;7507.211742767013;7575.242475752436;7579.20418356073;7482.551046937174;7581.469297149201;7585;7589.165191828922;7603.23967603238;7557.811054723621;7609.6956121755065;7618.162002179756;7629.923700762977;7632.6946922123325;7522.548647081193;7553.169151393342;7568.129665088531;7576.621168941559;7577.090749110087;7281.05346304977;7351.154617218981;7356.264373562654;7363.263673632648;7381.188069312371;34782.30435391303;34875.6512434875;34902;34968.65031349679;35270.29459410823;3440.7247420206572;3471.930561388783;3477.634848340913;3490.3193877193958;3491.7555771096036;27743;27881.16356509308;27905;27913.720862791317;27950.3012424691;3673.1000904778234;3717.200801827593;3721.162738383869;3724.3110024645525;3738.1962877981364;139412;141361;154593.22703386637;159811;160414;41677.583224167975;41778.79110604428;41984.160316793495;42004.36993445101;42512;44054.33918491225;44318;44456.22122119591;44473.33290000653;44568.55431445709;14434.206118663575;14484;14617.561473155822;14635.926820366043;14702.77945830792;11778.52885884555;11836.940815295868;11901.88098119025;11968.880311196777;11990.760184796256;13212.933935330455;13231.66920826987;13246.73506529864;13367;13380.264085475392;5309.362876454773;5425.779943385774;5511.421300763443;5556.91664625031;5587.888242235133;976.0971101731012;984.4290311619387;988.1205726903062;996.0985308296003;1000.9449480278508;22063;22144.2249521266;22621.321360359216;22939.541209175724;23440.17959371414;1075.231209685079;1081.561967403203;1084.2572837606265;1087.4671411008708;1139.3448766959032;11556.711082223012;11791.469383877746;11795.705107372212;12244.81632775509;12462.5014999399;193801;195255;195853;196412;196737;45859.77070114628;46471.767641161576;46689.29966050512;46996;47003;1377.6349267444136;1432.1621851216946;1437.8274607047013;1445.6530432696288;1449.9420023199166;20663.276785312442;21167;22606;22853.08587656475;22863.027806385064;33906.83046584751;33913.49129763105;33925.3214935695;33951.49072763861;34147;170786;171998.14000929915;172425;172648.13675932042;173025.13487432984;30482.84758576193;30493.847530762203;30646.387072258876;32551;32567.837160814994;40988;41991.58008419999;42005.36991945184;42061.789691052574;42532.1493570133;28589.28526786847;30278;30462.695373046874;30997.535036974914;32088.358232834744;29443.85278073596;29748.405031899674;30112.397752045275;30427;30892.691073088983;33680;34428.655713442546;35552.46671299984;35567.64432355644;35899.28201435904;28849.85575072111;29320.853395732884;29721.851390742908;30374.69625303807;31692;23201.767982320634;24139;24414.75585244125;24748.50502989966;24921.875390622932 02:53:45 INFO - PID 1338 | |2;jquery.html;409.8606473798908;421.5992986120759;428.5585846578024;440.51763319165514;441.3313829548233;14678.192699401528;15150.090994540335;20516.589668206627;21192.576148477023;21196.576068478622;21804.563908721815;22501;22532.54934901301;22600.88699556504;22624.8868755656;5895.056790913444;6005.4895333896675;6067.817965461043;6070.635761854281;6074.51403887688;5896.204012458306;5935;5944.316403613597;5975.223220981266;5986.461218490335;5710.371859095496;5740.7703691852275;5753.827385178431;5935.73289201987;5951.285845698522;5791.247137872092;5798.275215598051;5848.912266316009;5861.765529378862;5862.443067908542;5257.263983042377;5265.210218467222;5281.207818827168;5283.841484755463;5292.52367286946;24225;24501.63247551288;24523.509529809482;24573.38566535833;24573.38566535851;1891.3758459708401;1906.3518403742655;1913.5120544261263;1920.6062757134753;1921.3851567498407;14399;16349.673006539922;16375.59061023472;16431.753523697153;16436.260368283456;2195.9890200548894;2197.9340619781433;2262.6379779235244;2265.682804407384;2268.5236100418933;108224;110639;111043.88956110417;111189;111277.44361278223;10602.36385816838;11443.885561144281;11459.77080458386;11643.126765492621;11767.176297659253;16235.512934611981;16274.837251627332;16287.104209268604;16318.75521867173;16348.264328105264;8524.147585241426;8537.932758405199;8550.674645429968;8551.444156129832;8692.478451292942;8075.3539716822515;8123.593820308961;8172.141925097898;8174.877376839352;8223;7181.533200341961;7353.852922941511;7376.926230737731;7408.259174082548;7421.925780742232;2082.6251274770384;2095.3818623506104;2100.6008858316873;2116.9364919052455;2226.743924448677;935.7988032572894;979.1303659116093;979.9853002204973;984.6110786239395;992.9255305851946;18240.087995600166;19177.616447671247;19344.806551934584;19373.225070997283;19408.61182776365;944.9291303152291;973.9464329461948;1005.9899401006043;1013.7110923386799;1041.2974786224577;10176.575279460882;10308.484575771181;10311.175105991502;10587.364758114538;10634.627788027381;416299;419755;420964;435295;437863;95029;96224;96301;96714;97039;1146.7018575170348;1160.4371879638368;1168.199783148546;1178.0398974835653;1183;15989.802039591896;16277.953834311402;16853;16913.23890424909;18014.2794288227;46274.53725462837;46593.76703116463;47897.281540777614;48330.275045873634;48532.757336214505;59340;59425.405745941986;59592.167292398;59746.103808442036;59833.70083149557;9842.21262299;10074.19406447497;10090.19278457707;10111.191104711752;10135;16453.341866325693;17223.7416438756;17977.022527522222;18035.368762093265;18185.09074546241;12935.611931642066;13805.17168969865;13841.577723898075;13842.584722458343;14031.579052628438;12999.870001299865;13157.53948611794;13231.206127632373;13484.528041518499;13672.179669219879;15261.389544418098;15268.083914965138;15268.160251186291;15420.9228953859;15425.614359641098;10066.993300670167;10241.641542546273;10249.33379330341;10316.793664126526;10336.689899303034;13531;13890.722185556435;14048.227347495986;14478.972943788089;14672.633184170481 02:53:45 INFO - PID 1338 | |3;mootools.html;1279.4562311017814;1331.7269959658272;1337.2578219088402;1339.9866001339988;1341.885939695127;10881.727956801084;11221.214514983954;11423.828642570368;11443.084553235742;11494.770104597903;11280.887191128086;11435.313881167136;11476.598319058834;11507.07943364531;11510.366929818856;2338.1582630253097;2403.9302510382886;2404.675368825204;2405.302462285935;2418.903243870243;2237.6196046672103;2331.895064722092;2410.650455683925;2427.3446169534213;2437.293184976355;2394.090245706629;2418.5525677749583;2456.2140115163156;2457.8771061446855;2468.3705655058025;2382.976170238293;2383.4994651123197;2386.9880650596724;2390.378501589582;2392.557376885282;2314.3866875278063;2341.6019276723;2353.470469144446;2362.5393048355577;2362.8227882908677;10771.030607245308;10951.397673127974;10971.506282217319;10989.725256868562;11017.228793984425;6099.48154406876;6287.52843536732;6301.747930082791;6308.053791931201;6309.116723658692;3591.2637909228806;3842.8654997075246;3914.6476817086314;3935.3506671399186;3942.664873485757;1350.2303686898472;1354.7222819322014;1392.3595146232744;1397.7553928062548;1410.781328894023;14148.92925535376;14655.63360915975;16273.83726162735;16337.26482308299;16340.34638614454;5237.083510385667;5420.647657902224;5431.429699881455;5447.509724124769;5452.154915988028;12206.938965305295;12268.38658067111;12319.076069294839;12349.19730217533;12364.56724014655;6300.338464461257;6351.174347334817;6366.9681651591445;6368.426841584187;6369.681515924185;5847.9415205848245;6003.0695242237525;6033.78881739137;6034.853377858193;6050.606710563799;4032.4306568252773;4130.215259100822;4139.2043198602305;4151.418801367811;4216.47294088239;1102.090775110537;1114.2367478277406;1123.4831977290537;1128.836318733779;1128.8476055732372;827.9337652987747;857.4598003258033;860.655737704923;867.6659486097772;895.6417433026711;5806.2451881255165;5908.940910590925;6020.69896505173;6106.4809491192855;6200.441960223601;944.390867890207;986.9932668677908;987.111599560387;991.0881988570533;992.593036854886;4545.2954792007295;4691.296305554194;4701.318308845198;4809.254565542346;4979.950200497949;13845.100068495516;14259.643508912153;14269.714605707828;14298.785518217235;14396.856031439762;13659.931700341434;13866.791998120036;14102.083364581269;14295.714085718228;14312.57062288133;8891.46651200917;9063.637454501746;9103.635854565875;9104.681336153202;9112.681056163136;6522.673866306761;6616.735330586916;6925.3074692530345;7021.754238601625;7260.491765576359;12661.366931653196;12716.74566508646;12791.808122877977;12903.225806451643;12980;11602.535898563963;12774.169678970837;13289.86710132925;13321.866781332063;13371.130876492996;8762.430442021248;8835.734927952171;8931.508767017876;8963.372563920462;8978.236849867835;10414.583416663248;10601.204909631655;10618.8407173894;10643.733906652396;10729;8859.645614175619;8968.148025937526;8988.955055224944;9073.364864459689;9219.354645174773;8570.271526920282;8580.613872375883;8663.870041949249;8683.782905427162;8746.91253087461;7935.801604959922;8104.594770261581;8131.634076466691;8158.4289099762445;8168.142345053684;5675.687837168995;5847.06446968483;6007.789727359696;6060.878782424415;6169.660668663087;6185.597936134137;6307.495400368051;6349.555531112963;6500.674966251574;6682.899756503753 02:53:45 INFO - PID 1338 | |4;prototype.html;383.90594304395427;404.72680940365257;405.5336363182342;406.05591998603245;406.3072461453221;6218.62688238706;6363.236411630599;6367.586106903048;6376.234851817777;6426.325235850232;6076.513878889689;6135.570510064297;6147.262328520584;6172.567920245585;6173;4788.9521104788855;4810.254410566367;4814.3019262207135;4818.9036219275595;4827.03459308138;4802.399700037496;4826.420829500465;4827.082854257697;4836.15367310721;4859.951400485986;4784.162771514988;4790.808367665307;4795.832145874895;4802;4803.831865884695;4767.690100143514;4774.188387974053;4783.497732738065;4784.330193772875;4808.682009413528;4181.770002649853;4190.036291652907;4194.140201258765;4196.874093777192;4206;6113.84258704081;6128.3565225651555;6158.322584515699;6177.517395825014;6191.133241346215;5507.7246137693355;5510.393856675802;5514.448555144493;5520.447955204448;5523.861903452405;6531.706073226716;6558.8360290993105;6572.6667033203485;6582.736690532373;6597.274299827015;4553.772311384418;4560.8859778505475;4566.54334566544;4567.451905771329;4577.8397756078375;6563.5888284019165;6663.400293973517;6801.803152518309;6931.68807403663;7039.190493093309;4566.840160594364;4604.2964103282;4614.123316569841;4628.514006029386;4660.627149828006;4674;4699.882502937454;4700.811967521261;4705;4718.787654555554;5325.254464374991;5416.539594134542;5435.130379139318;5443.319585051869;5472.226800725273;6557.180352455943;6601.207855057424;6629.105070815378;6630.336966303427;6634.23706273775;1629.2994012574707;1631.6981358448725;1632.7469242267468;1637.7379619260862;1641.433705371645;1061.994690026545;1093.9343639381664;1095.59462998691;1102.2504696806088;1102.3826657072066;5870.882582348329;5879.941200588025;5905.970470147708;5919.526437884959;5923.851903702442;6775.186977562724;6807.319268073153;6849.657517124124;6850.520463567503;6854.383105520527;5816.720321529257;5851.941480585225;5880.705964701748;5897.616654917417;5903.498202652737;3609.8917032489067;3615.6022837487853;3620.153721601949;3625.510556074949;3657.3965295725907;6532.738690452424;6579.80260592183;6595.604263744191;6600.471962243009;6636.203655561363;6967.965160174167;6972.721091156297;6991.720331186695;6992.475564332593;7005.92994070063;6550.410463058348;6584.308647591934;6591.978243372285;6592.571482853599;6616.603003819786;6829.385355318045;6834.829129271609;6840.692168852314;6841.692123854538;6887.793366199022;6730.259671436236;6756.898646520208;6774.288699686462;6774.559653622498;6795.762148324785;6228.190335256388;6575.736970521126;6581.243157037002;6586.407223349922;6588.40704336612;4574;4589.5639914208095;4603.171429142786;4607.424071991001;4624.531601299026;6761.560498567577;6766.594004359557;6780.254172040973;6844.794656160323;6847;6403.6157830528455;6608.867822643617;6622.37087476689;6622.841002824583;6677.432418244503;6611.570247933869;6654.334566543501;6667.633280169637;6673.866522669422;6677.732890684512;6518.706658200297;6527.11883895687;6552.985626611812;6561.311062338385;6580.934190658032;6640;6646.8005959821285;6673;6680.331966803476;6730.93269067303;6483.286838447862;6504.544681872224;6511.576747511396;6513.316101809241;6527 02:53:45 INFO - PID 1338 | |5;yui.html;825.0800357601277;840.4327079221525;850.1201256699318;856.4861083349991;869.4739682492094;14689;15288;16231.26959286832;16787.83212167878;16808.747868781946;17457.563560910985;17636;17993.280268789233;18079.276828926828;18159.273629054824;944.5466176235411;971.4996776660025;975.1564896364664;975.1662328708958;977.9315447918649;925.8750068740735;961.1157734883924;965.7826988927505;966.1063516247478;967.0281367225963;1019.7246743379283;1029.5881647341048;1029.9227557933184;1029.9742506437324;1031.1338475680427;1024.165305276205;1024.733569271987;1024.861643678105;1026.563710423071;1028.5371582787739;751.7406494759299;754.977350679475;755.5768769489104;755.8639444899916;756.4364548411469;16932.576685582837;17105.91447042769;17197;17359.826401735947;17494.737578936325;18387.72418413725;18604.44186674402;18723.906380468146;18770.624587508173;18949.526261843428;13379.397927093305;13950.51173208943;13953.441862325495;13960.371783269777;13968.58094257174;3461.394256005189;3512.59605145409;3518.9120271993147;3520.7887526748223;3526.2418580005424;97499;98068.50965745126;99426.50286748592;99470.53441526278;101544;14952.028118172284;14969.101853888802;15091.54725358241;15210.391584336723;15279.312430940634;27290.590641140003;28210.576841347396;28429.715702842706;28577.428451430857;28634.856825716153;7991.480553763987;8088.433809633387;8477.872831907527;8487;8493.278071364004;3936.2324346752107;4004.5594984551676;4030.274550580865;4041.333180025322;4046.0289530513055;4008.4388185654034;4115.34154535273;4136.193442278727;4137.213929353413;4265.786710664516;849.9575021248913;852.8912413861955;858.6565373850385;864.8616221404545;864.9135086491301;660.9834754131185;691.9965400172966;694.3334398977039;696.1785093589613;705.8835292176733;10280.228982826318;10979.39613321275;11006.064484518745;11787.174897757246;12358.876411235773;684.8801459744525;687.3092541995263;690.702997710979;692.5256199503357;707.1231672725783;5126.179811230185;5182.140436590908;5296.285001524822;5322.707251101149;5356.839294821161;90012.54993724989;91472;91858;92325.53837230771;93761.5311923436;80589.59705201554;81671;82150;82445.17554824495;82968.17031829726;68824.31175688178;69689;70513.94229086569;70670.2932970674;71427;10195.490225488844;10274.640387586398;10384.896151038392;10817.296875703054;11188.88811111911;29973.250668733457;31068;31330;31399.52900706537;31861.840690796398;40075;40225;40376.39435408413;40426.59573404228;40950.9762255946;14630.487932922297;14934.55196344068;15135.924320378328;15186.544403667907;15314.540563783105;15723;16593.75109373336;17773.20020599102;18312.542186445444;18450;15725.292361843516;15797.526074217792;15849.494298041667;16100.355985760438;16193.02841829494;15571.922140389226;15631.765523517384;15834.683306333578;15896.284667190235;16229.350825966829;15701.528954131394;17002.06488643087;17104.82895171082;17124.743128853326;17389.47831565055;9877.703668889944;10458.58165673395;10519.94740026295;10754.408507531847;10822.621208257673;11492.253003554742;11845.52617895309;12122.27266364021;12130.090243231969;12306.630801075982 02:53:45 INFO - PID 1338 | __end_tp_report 02:53:45 INFO - PID 1338 | __start_cc_report 02:53:45 INFO - PID 1338 | _x_x_mozilla_cycle_collect,394 02:53:45 INFO - PID 1338 | __end_cc_report 02:53:45 INFO - PID 1338 | __startTimestamp1496656425972__endTimestamp 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | ------- Summary: start ------- 02:53:45 INFO - PID 1338 | Number of tests: 6 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | [#0] dojo.html Cycles:165 Average:6018.05 Median:6271.81 stddev:689.47 (11.0%) stddev-sans-first:653.98 02:53:45 INFO - PID 1338 | Values: 3155.3 3162.9 3165.2 3191.4 3191.9 5859.1 6022.8 6035.9 6071.0 6072.1 6073.1 6077.2 6112.2 6119.0 6137.3 5466.8 5600.4 5603.9 5609.7 5655.9 5670.7 5679.3 5682.7 5691.0 5694.8 5442.0 5485.8 5494.9 5565.0 5592.5 5560.0 5593.5 5615.4 5633.6 5652.2 5563.0 5567.9 5574.6 5575.7 5614.2 5895.8 5960.0 6018.0 6036.2 6095.5 6372.0 6534.8 6555.7 6567.9 6574.3 6633.4 6646.3 6650.1 6650.1 6653.1 6006.3 6140.8 6141.7 6141.7 6146.6 6620.4 6668.3 6688.4 6753.0 6784.4 6271.5 6280.6 6348.8 6426.1 6428.0 6575.1 6580.9 6590.3 6594.5 6600.6 6303.3 6517.8 6532.3 6543.7 6555.7 6400.1 6428.2 6503.6 6507.6 6546.4 5363.2 5364.6 5368.2 5371.7 5405.7 4548.2 4554.5 4567.7 4569.0 4603.1 5594.4 5664.1 5666.9 5721.5 5744.4 6523.9 6543.6 6544.4 6547.6 6548.7 5676.6 5678.8 5688.1 5700.3 5733.7 5709.5 5734.9 5786.7 5791.9 5804.6 6208.5 6286.2 6289.6 6299.2 6318.7 6550.8 6558.4 6575.4 6577.0 6578.0 6312.5 6330.6 6410.1 6410.7 6414.7 6164.3 6208.5 6387.6 6424.5 6443.6 6547.2 6576.8 6580.6 6595.3 6600.1 6205.1 6249.8 6306.8 6373.3 6403.0 6319.3 6404.0 6410.8 6414.6 6420.5 6119.3 6271.8 6342.4 6348.2 6359.8 6336.0 6370.9 6395.2 6412.1 6447.0 6281.5 6284.2 6306.1 6310.1 6315.0 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | [#1] ext.html Cycles:180 Average:33276.85 Median:33919.41 stddev:44893.90 (132.4%) stddev-sans-first:44953.29 02:53:45 INFO - PID 1338 | Values: 724.7 766.0 786.2 1119.6 1138.2 35828.0 36781.3 36833.8 36848.0 36851.3 38064.8 38265.6 38515.4 38620.2 38656.4 7319.5 7446.3 7507.2 7575.2 7579.2 7482.6 7581.5 7585.0 7589.2 7603.2 7557.8 7609.7 7618.2 7629.9 7632.7 7522.5 7553.2 7568.1 7576.6 7577.1 7281.1 7351.2 7356.3 7363.3 7381.2 34782.3 34875.7 34902.0 34968.7 35270.3 3440.7 3471.9 3477.6 3490.3 3491.8 27743.0 27881.2 27905.0 27913.7 27950.3 3673.1 3717.2 3721.2 3724.3 3738.2 139412.0 141361.0 154593.2 159811.0 160414.0 41677.6 41778.8 41984.2 42004.4 42512.0 44054.3 44318.0 44456.2 44473.3 44568.6 14434.2 14484.0 14617.6 14635.9 14702.8 11778.5 11836.9 11901.9 11968.9 11990.8 13212.9 13231.7 13246.7 13367.0 13380.3 5309.4 5425.8 5511.4 5556.9 5587.9 976.1 984.4 988.1 996.1 1000.9 22063.0 22144.2 22621.3 22939.5 23440.2 1075.2 1081.6 1084.3 1087.5 1139.3 11556.7 11791.5 11795.7 12244.8 12462.5 193801.0 195255.0 195853.0 196412.0 196737.0 45859.8 46471.8 46689.3 46996.0 47003.0 1377.6 1432.2 1437.8 1445.7 1449.9 20663.3 21167.0 22606.0 22853.1 22863.0 33906.8 33913.5 33925.3 33951.5 34147.0 170786.0 171998.1 172425.0 172648.1 173025.1 30482.8 30493.8 30646.4 32551.0 32567.8 40988.0 41991.6 42005.4 42061.8 42532.1 28589.3 30278.0 30462.7 30997.5 32088.4 29443.9 29748.4 30112.4 30427.0 30892.7 33680.0 34428.7 35552.5 35567.6 35899.3 28849.9 29320.9 29721.9 30374.7 31692.0 23201.8 24139.0 24414.8 24748.5 24921.9 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | [#2] jquery.html Cycles:180 Average:29234.77 Median:21500.57 stddev:71428.67 (332.2%) stddev-sans-first:71596.26 02:53:45 INFO - PID 1338 | Values: 409.9 421.6 428.6 440.5 441.3 14678.2 15150.1 20516.6 21192.6 21196.6 21804.6 22501.0 22532.5 22600.9 22624.9 5895.1 6005.5 6067.8 6070.6 6074.5 5896.2 5935.0 5944.3 5975.2 5986.5 5710.4 5740.8 5753.8 5935.7 5951.3 5791.2 5798.3 5848.9 5861.8 5862.4 5257.3 5265.2 5281.2 5283.8 5292.5 24225.0 24501.6 24523.5 24573.4 24573.4 1891.4 1906.4 1913.5 1920.6 1921.4 14399.0 16349.7 16375.6 16431.8 16436.3 2196.0 2197.9 2262.6 2265.7 2268.5 108224.0 110639.0 111043.9 111189.0 111277.4 10602.4 11443.9 11459.8 11643.1 11767.2 16235.5 16274.8 16287.1 16318.8 16348.3 8524.1 8537.9 8550.7 8551.4 8692.5 8075.4 8123.6 8172.1 8174.9 8223.0 7181.5 7353.9 7376.9 7408.3 7421.9 2082.6 2095.4 2100.6 2116.9 2226.7 935.8 979.1 980.0 984.6 992.9 18240.1 19177.6 19344.8 19373.2 19408.6 944.9 973.9 1006.0 1013.7 1041.3 10176.6 10308.5 10311.2 10587.4 10634.6 416299.0 419755.0 420964.0 435295.0 437863.0 95029.0 96224.0 96301.0 96714.0 97039.0 1146.7 1160.4 1168.2 1178.0 1183.0 15989.8 16278.0 16853.0 16913.2 18014.3 46274.5 46593.8 47897.3 48330.3 48532.8 59340.0 59425.4 59592.2 59746.1 59833.7 9842.2 10074.2 10090.2 10111.2 10135.0 16453.3 17223.7 17977.0 18035.4 18185.1 12935.6 13805.2 13841.6 13842.6 14031.6 12999.9 13157.5 13231.2 13484.5 13672.2 15261.4 15268.1 15268.2 15420.9 15425.6 10067.0 10241.6 10249.3 10316.8 10336.7 13531.0 13890.7 14048.2 14479.0 14672.6 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | [#3] mootools.html Cycles:180 Average:6926.77 Median:3717.06 stddev:4307.26 (115.9%) stddev-sans-first:4298.43 02:53:45 INFO - PID 1338 | Values: 1279.5 1331.7 1337.3 1340.0 1341.9 10881.7 11221.2 11423.8 11443.1 11494.8 11280.9 11435.3 11476.6 11507.1 11510.4 2338.2 2403.9 2404.7 2405.3 2418.9 2237.6 2331.9 2410.7 2427.3 2437.3 2394.1 2418.6 2456.2 2457.9 2468.4 2383.0 2383.5 2387.0 2390.4 2392.6 2314.4 2341.6 2353.5 2362.5 2362.8 10771.0 10951.4 10971.5 10989.7 11017.2 6099.5 6287.5 6301.7 6308.1 6309.1 3591.3 3842.9 3914.6 3935.4 3942.7 1350.2 1354.7 1392.4 1397.8 1410.8 14148.9 14655.6 16273.8 16337.3 16340.3 5237.1 5420.6 5431.4 5447.5 5452.2 12206.9 12268.4 12319.1 12349.2 12364.6 6300.3 6351.2 6367.0 6368.4 6369.7 5847.9 6003.1 6033.8 6034.9 6050.6 4032.4 4130.2 4139.2 4151.4 4216.5 1102.1 1114.2 1123.5 1128.8 1128.8 827.9 857.5 860.7 867.7 895.6 5806.2 5908.9 6020.7 6106.5 6200.4 944.4 987.0 987.1 991.1 992.6 4545.3 4691.3 4701.3 4809.3 4980.0 13845.1 14259.6 14269.7 14298.8 14396.9 13659.9 13866.8 14102.1 14295.7 14312.6 8891.5 9063.6 9103.6 9104.7 9112.7 6522.7 6616.7 6925.3 7021.8 7260.5 12661.4 12716.7 12791.8 12903.2 12980.0 11602.5 12774.2 13289.9 13321.9 13371.1 8762.4 8835.7 8931.5 8963.4 8978.2 10414.6 10601.2 10618.8 10643.7 10729.0 8859.6 8968.1 8989.0 9073.4 9219.4 8570.3 8580.6 8663.9 8683.8 8746.9 7935.8 8104.6 8131.6 8158.4 8168.1 5675.7 5847.1 6007.8 6060.9 6169.7 6185.6 6307.5 6349.6 6500.7 6682.9 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | [#4] prototype.html Cycles:180 Average:5468.48 Median:6165.45 stddev:1629.81 (26.4%) stddev-sans-first:1589.07 02:53:45 INFO - PID 1338 | Values: 383.9 404.7 405.5 406.1 406.3 6218.6 6363.2 6367.6 6376.2 6426.3 6076.5 6135.6 6147.3 6172.6 6173.0 4789.0 4810.3 4814.3 4818.9 4827.0 4802.4 4826.4 4827.1 4836.2 4860.0 4784.2 4790.8 4795.8 4802.0 4803.8 4767.7 4774.2 4783.5 4784.3 4808.7 4181.8 4190.0 4194.1 4196.9 4206.0 6113.8 6128.4 6158.3 6177.5 6191.1 5507.7 5510.4 5514.4 5520.4 5523.9 6531.7 6558.8 6572.7 6582.7 6597.3 4553.8 4560.9 4566.5 4567.5 4577.8 6563.6 6663.4 6801.8 6931.7 7039.2 4566.8 4604.3 4614.1 4628.5 4660.6 4674.0 4699.9 4700.8 4705.0 4718.8 5325.3 5416.5 5435.1 5443.3 5472.2 6557.2 6601.2 6629.1 6630.3 6634.2 1629.3 1631.7 1632.7 1637.7 1641.4 1062.0 1093.9 1095.6 1102.3 1102.4 5870.9 5879.9 5906.0 5919.5 5923.9 6775.2 6807.3 6849.7 6850.5 6854.4 5816.7 5851.9 5880.7 5897.6 5903.5 3609.9 3615.6 3620.2 3625.5 3657.4 6532.7 6579.8 6595.6 6600.5 6636.2 6968.0 6972.7 6991.7 6992.5 7005.9 6550.4 6584.3 6592.0 6592.6 6616.6 6829.4 6834.8 6840.7 6841.7 6887.8 6730.3 6756.9 6774.3 6774.6 6795.8 6228.2 6575.7 6581.2 6586.4 6588.4 4574.0 4589.6 4603.2 4607.4 4624.5 6761.6 6766.6 6780.3 6844.8 6847.0 6403.6 6608.9 6622.4 6622.8 6677.4 6611.6 6654.3 6667.6 6673.9 6677.7 6518.7 6527.1 6553.0 6561.3 6580.9 6640.0 6646.8 6673.0 6680.3 6730.9 6483.3 6504.5 6511.6 6513.3 6527.0 02:53:45 INFO - PID 1338 | 02:53:45 INFO - PID 1338 | [#5] yui.html Cycles:180 Average:19447.78 Median:30520.63 stddev:25524.41 (83.6%) stddev-sans-first:25557.71 02:53:45 INFO - PID 1338 | Values: 825.1 840.4 850.1 856.5 869.5 14689.0 15288.0 16231.3 16787.8 16808.7 17457.6 17636.0 17993.3 18079.3 18159.3 944.5 971.5 975.2 975.2 977.9 925.9 961.1 965.8 966.1 967.0 1019.7 1029.6 1029.9 1030.0 1031.1 1024.2 1024.7 1024.9 1026.6 1028.5 751.7 755.0 755.6 755.9 756.4 16932.6 17105.9 17197.0 17359.8 17494.7 18387.7 18604.4 18723.9 18770.6 18949.5 13379.4 13950.5 13953.4 13960.4 13968.6 3461.4 3512.6 3518.9 3520.8 3526.2 97499.0 98068.5 99426.5 99470.5 101544.0 14952.0 14969.1 15091.5 15210.4 15279.3 27290.6 28210.6 28429.7 28577.4 28634.9 7991.5 8088.4 8477.9 8487.0 8493.3 3936.2 4004.6 4030.3 4041.3 4046.0 4008.4 4115.3 4136.2 4137.2 4265.8 850.0 852.9 858.7 864.9 864.9 661.0 692.0 694.3 696.2 705.9 10280.2 10979.4 11006.1 11787.2 12358.9 684.9 687.3 690.7 692.5 707.1 5126.2 5182.1 5296.3 5322.7 5356.8 90012.5 91472.0 91858.0 92325.5 93761.5 80589.6 81671.0 82150.0 82445.2 82968.2 68824.3 69689.0 70513.9 70670.3 71427.0 10195.5 10274.6 10384.9 10817.3 11188.9 29973.3 31068.0 31330.0 31399.5 31861.8 40075.0 40225.0 40376.4 40426.6 40951.0 14630.5 14934.6 15135.9 15186.5 15314.5 15723.0 16593.8 17773.2 18312.5 18450.0 15725.3 15797.5 15849.5 16100.4 16193.0 15571.9 15631.8 15834.7 15896.3 16229.4 15701.5 17002.1 17104.8 17124.7 17389.5 9877.7 10458.6 10519.9 10754.4 10822.6 11492.3 11845.5 12122.3 12130.1 12306.6 02:53:45 INFO - PID 1338 | -------- Summary: end -------- 02:53:45 INFO - PID 1338 | 02:53:46 INFO - TEST-INFO | 1338: exit 0 02:53:46 INFO - TEST-OK | dromaeo_css | took 1142711ms 02:53:46 INFO - TEST-START | kraken 02:53:46 INFO - operating with platform_type : linux_ 02:53:46 INFO - Initialising browser for kraken test... 02:53:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54717/getInfo.html -profile /tmp/tmpN6o2Kk/profile 02:53:46 INFO - TEST-INFO | started process 1749 (/builds/slave/test/build/application/firefox/firefox http://localhost:54717/getInfo.html) 02:54:22 INFO - TEST-INFO | 1749: killed by SIGTERM 02:54:22 INFO - Browser initialized. 02:54:22 INFO - Running cycle 1/1 for kraken test... 02:54:22 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN6o2Kk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:34 INFO - PID 1956 | RSS: Main: 188256256 02:54:34 INFO - PID 1956 | 02:54:36 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54717/tests/kraken/driver.html?testName=audio-beat-detection) 02:54:37 INFO - PID 1956 | RSS: Main: 192454656 02:54:37 INFO - PID 1956 | 02:54:40 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54717/tests/kraken/driver.html?testName=audio-dft) 02:54:40 INFO - PID 1956 | RSS: Main: 190709760 02:54:40 INFO - PID 1956 | 02:54:43 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54717/tests/kraken/driver.html?testName=audio-fft) 02:54:44 INFO - PID 1956 | RSS: Main: 186118144 02:54:44 INFO - PID 1956 | 02:54:46 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54717/tests/kraken/driver.html?testName=audio-oscillator) 02:54:47 INFO - PID 1956 | RSS: Main: 186568704 02:54:47 INFO - PID 1956 | 02:54:49 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:54:49 INFO - PID 1956 | RSS: Main: 186847232 02:54:49 INFO - PID 1956 | 02:54:52 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54717/tests/kraken/driver.html?testName=imaging-darkroom) 02:54:53 INFO - PID 1956 | RSS: Main: 188379136 02:54:53 INFO - PID 1956 | 02:54:56 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54717/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:57 INFO - PID 1956 | RSS: Main: 187146240 02:54:57 INFO - PID 1956 | 02:55:00 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54717/tests/kraken/driver.html?testName=json-parse-financial) 02:55:01 INFO - PID 1956 | RSS: Main: 188129280 02:55:01 INFO - PID 1956 | 02:55:02 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:55:03 INFO - PID 1956 | RSS: Main: 188227584 02:55:03 INFO - PID 1956 | 02:55:05 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:55:05 INFO - PID 1956 | RSS: Main: 187752448 02:55:05 INFO - PID 1956 | 02:55:07 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:55:08 INFO - PID 1956 | RSS: Main: 188071936 02:55:08 INFO - PID 1956 | 02:55:11 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:55:11 INFO - PID 1956 | RSS: Main: 187781120 02:55:11 INFO - PID 1956 | 02:55:15 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:55:15 INFO - PID 1956 | RSS: Main: 187703296 02:55:15 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | Cycle 1(1): loaded http://localhost:54717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54717/tests/kraken/driver.html?testName=ai-astar) 02:55:17 INFO - PID 1956 | RSS: Main: 189095936 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | __start_tp_report 02:55:17 INFO - PID 1956 | _x_x_mozilla_page_load 02:55:17 INFO - PID 1956 | _x_x_mozilla_page_load_details 02:55:17 INFO - PID 1956 | |i|pagename|runs| 02:55:17 INFO - PID 1956 | |0;ai-astar;101;110;110;112;111;111;111;111;110;112 02:55:17 INFO - PID 1956 | |1;audio-beat-detection;146;120;123;168;121;120;121;122;146;121 02:55:17 INFO - PID 1956 | |2;audio-dft;163;165;163;161;163;164;165;171;167;169 02:55:17 INFO - PID 1956 | |3;audio-fft;77;75;74;119;74;75;75;75;99;73 02:55:17 INFO - PID 1956 | |4;audio-oscillator;81;82;107;83;81;82;108;83;82;101 02:55:17 INFO - PID 1956 | |5;imaging-gaussian-blur;115;116;114;114;114;114;114;114;124;114 02:55:17 INFO - PID 1956 | |6;imaging-darkroom;150;151;153;154;154;153;149;150;149;151 02:55:17 INFO - PID 1956 | |7;imaging-desaturate;94;96;95;95;96;94;94;94;94;94 02:55:17 INFO - PID 1956 | |8;json-parse-financial;58;55;57;55;58;55;58;56;55;56 02:55:17 INFO - PID 1956 | |9;json-stringify-tinderbox;54;55;54;55;55;55;55;54;55;54 02:55:17 INFO - PID 1956 | |10;stanford-crypto-aes;96;87;84;85;85;86;87;87;106;96 02:55:17 INFO - PID 1956 | |11;stanford-crypto-ccm;133;136;132;146;131;128;132;131;132;134 02:55:17 INFO - PID 1956 | |12;stanford-crypto-pbkdf2;189;193;193;195;204;202;208;195;193;192 02:55:17 INFO - PID 1956 | |13;stanford-crypto-sha256-iterative;71;73;72;71;74;72;70;76;70;70 02:55:17 INFO - PID 1956 | __end_tp_report 02:55:17 INFO - PID 1956 | __start_cc_report 02:55:17 INFO - PID 1956 | _x_x_mozilla_cycle_collect,994 02:55:17 INFO - PID 1956 | __end_cc_report 02:55:17 INFO - PID 1956 | __startTimestamp1496656517739__endTimestamp 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | ------- Summary: start ------- 02:55:17 INFO - PID 1956 | Number of tests: 14 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.21 (2.9%) stddev-sans-first:0.78 02:55:17 INFO - PID 1956 | Values: 101.0 110.0 110.0 112.0 111.0 111.0 111.0 111.0 110.0 112.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:122.50 stddev:16.69 (13.6%) stddev-sans-first:16.77 02:55:17 INFO - PID 1956 | Values: 146.0 120.0 123.0 168.0 121.0 120.0 121.0 122.0 146.0 121.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.07 (1.9%) stddev-sans-first:3.16 02:55:17 INFO - PID 1956 | Values: 163.0 165.0 163.0 161.0 163.0 164.0 165.0 171.0 167.0 169.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:15.23 (20.3%) stddev-sans-first:16.06 02:55:17 INFO - PID 1956 | Values: 77.0 75.0 74.0 119.0 74.0 75.0 75.0 75.0 99.0 73.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:11.43 (13.9%) stddev-sans-first:11.75 02:55:17 INFO - PID 1956 | Values: 81.0 82.0 107.0 83.0 81.0 82.0 108.0 83.0 82.0 101.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:114.00 stddev:3.13 (2.7%) stddev-sans-first:3.32 02:55:17 INFO - PID 1956 | Values: 115.0 116.0 114.0 114.0 114.0 114.0 114.0 114.0 124.0 114.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:152.00 stddev:1.96 (1.3%) stddev-sans-first:2.01 02:55:17 INFO - PID 1956 | Values: 150.0 151.0 153.0 154.0 154.0 153.0 149.0 150.0 149.0 151.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 02:55:17 INFO - PID 1956 | Values: 94.0 96.0 95.0 95.0 96.0 94.0 94.0 94.0 94.0 94.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.34 (2.4%) stddev-sans-first:1.27 02:55:17 INFO - PID 1956 | Values: 58.0 55.0 57.0 55.0 58.0 55.0 58.0 56.0 55.0 56.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 02:55:17 INFO - PID 1956 | Values: 54.0 55.0 54.0 55.0 55.0 55.0 55.0 54.0 55.0 54.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.00 stddev:7.13 (8.2%) stddev-sans-first:7.21 02:55:17 INFO - PID 1956 | Values: 96.0 87.0 84.0 85.0 85.0 86.0 87.0 87.0 106.0 96.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:132.50 stddev:4.86 (3.7%) stddev-sans-first:5.15 02:55:17 INFO - PID 1956 | Values: 133.0 136.0 132.0 146.0 131.0 128.0 132.0 131.0 132.0 134.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:195.00 stddev:6.11 (3.1%) stddev-sans-first:5.87 02:55:17 INFO - PID 1956 | Values: 189.0 193.0 193.0 195.0 204.0 202.0 208.0 195.0 193.0 192.0 02:55:17 INFO - PID 1956 | 02:55:17 INFO - PID 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.97 (2.7%) stddev-sans-first:2.06 02:55:17 INFO - PID 1956 | Values: 71.0 73.0 72.0 71.0 74.0 72.0 70.0 76.0 70.0 70.0 02:55:17 INFO - PID 1956 | -------- Summary: end -------- 02:55:17 INFO - PID 1956 | 02:55:18 INFO - TEST-INFO | 1956: exit 0 02:55:18 INFO - TEST-OK | kraken | took 92010ms 02:55:18 INFO - SUITE-END | took 1234s 02:55:18 INFO - Completed test suite (00:20:34) 02:55:18 INFO - javascript benchmark 02:55:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7658.853893024524, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.258514249151, 3162.8892988745383, 3165.1612322734463, 3191.409589225992, 3191.904242872714, 5859.091840764689, 6022.75908963642, 6035.909461358083, 6070.969645151774, 6072.119542666316, 6073.119397687333, 6077.24034495688, 6112.235970503687, 6118.984682626211, 6137.31569828693, 5466.808661696841, 5600.355959064698, 5603.943960560403, 5609.663420194802, 5655.915161272585, 5670.68811215383, 5679.290088738908, 5682.687452190128, 5690.971545142289, 5694.829155125353, 5442.047641662693, 5485.807996720136, 5494.945050549483, 5565.0, 5592.496675299242, 5559.972200139014, 5593.496585307301, 5615.410381909882, 5633.57748168889, 5652.208690783294, 5562.972185139089, 5567.888642227133, 5574.637648552872, 5575.69333686647, 5614.214010038598, 5895.823125306248, 5960.04639257721, 6018.0, 6036.185115009462, 6095.481884039862, 6371.96814015927, 6534.836629084263, 6555.737770489175, 6567.934320656828, 6574.309697481744, 6633.4029937305395, 6646.26891041985, 6650.135482387307, 6650.135482387307, 6653.101831252768, 6006.279246490449, 6140.785072522441, 6141.692915354214, 6141.692915354214, 6146.569740118149, 6620.3710647488415, 6668.333166683293, 6688.398044176048, 6752.966235168793, 6784.3894049535775, 6271.498280137578, 6280.591761535577, 6348.809535713936, 6426.132472116298, 6427.967860160669, 6575.112359831457, 6580.901286480706, 6590.3080176581725, 6594.472442204612, 6600.60396376219, 6303.2751233607805, 6517.771877984248, 6532.314107018789, 6543.672816359163, 6555.737770489222, 6400.103985442041, 6428.164338635947, 6503.577267477599, 6507.642079685663, 6546.410823025855, 5363.19552067193, 5364.597655175878, 5368.194770784414, 5371.704556249444, 5405.675659460445, 4548.204064288736, 4554.453465584085, 4567.703099298535, 4569.040501494657, 4603.079384123189, 5594.356648985337, 5664.065429204217, 5666.914996275059, 5721.5136713379, 5744.396838331999, 6523.902141467882, 6543.607383556907, 6544.411003009657, 6547.639879806657, 6548.738050478023, 5676.602637815396, 5678.801241956594, 5688.089905615082, 5700.287464066992, 5733.713314334266, 5709.514691251207, 5734.942650573525, 5786.652800831879, 5791.8552036199435, 5804.622699524517, 6208.4722798562625, 6286.151369565142, 6289.591176573508, 6299.181106456132, 6318.747250109944, 6550.7707230246715, 6558.409743123142, 6575.375339342755, 6576.967115164393, 6578.046183303299, 6312.5265605078885, 6330.588511746721, 6410.102585637921, 6410.743570257324, 6414.743410263537, 6164.321924588202, 6208.503319734501, 6387.584806987531, 6424.51816113784, 6443.581167224115, 6547.181602299713, 6576.8355791105605, 6580.605163690194, 6595.340465953558, 6600.075989361397, 6205.131281620667, 6249.843753906007, 6306.779262725966, 6373.298937117006, 6403.039544068427, 6319.273283572448, 6404.039394090737, 6410.8076757697345, 6414.647194404352, 6420.486361091195, 6119.289302195972, 6271.811845644638, 6342.39747224013, 6348.238211414659, 6359.841003974752, 6335.968320158369, 6370.904436433365, 6395.16862807832, 6412.1343618612755, 6446.967765161145, 6281.466075383643, 6284.214473190851, 6306.054091886253, 6310.085037669421, 6315.0], "value": 5968.327382529094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.7246046502328, 766.0462723908734, 786.1509569664761, 1119.5857532712898, 1138.1577632551903, 35828.0, 36781.264374712526, 36833.815830920874, 36848.0, 36851.262974740486, 38064.80967595165, 38265.617343826554, 38515.42226866599, 38620.22759544807, 38656.42015369772, 7319.524230925, 7446.255374462551, 7507.211742767013, 7575.242475752436, 7579.20418356073, 7482.551046937174, 7581.469297149201, 7585.0, 7589.165191828922, 7603.23967603238, 7557.811054723621, 7609.6956121755065, 7618.162002179756, 7629.923700762977, 7632.6946922123325, 7522.548647081193, 7553.169151393342, 7568.129665088531, 7576.621168941559, 7577.090749110087, 7281.05346304977, 7351.154617218981, 7356.264373562654, 7363.263673632648, 7381.188069312371, 34782.30435391303, 34875.6512434875, 34902.0, 34968.65031349679, 35270.29459410823, 3440.7247420206572, 3471.930561388783, 3477.634848340913, 3490.3193877193958, 3491.7555771096036, 27743.0, 27881.16356509308, 27905.0, 27913.720862791317, 27950.3012424691, 3673.1000904778234, 3717.200801827593, 3721.162738383869, 3724.3110024645525, 3738.1962877981364, 139412.0, 141361.0, 154593.22703386637, 159811.0, 160414.0, 41677.583224167975, 41778.79110604428, 41984.160316793495, 42004.36993445101, 42512.0, 44054.33918491225, 44318.0, 44456.22122119591, 44473.33290000653, 44568.55431445709, 14434.206118663575, 14484.0, 14617.561473155822, 14635.926820366043, 14702.77945830792, 11778.52885884555, 11836.940815295868, 11901.88098119025, 11968.880311196777, 11990.760184796256, 13212.933935330455, 13231.66920826987, 13246.73506529864, 13367.0, 13380.264085475392, 5309.362876454773, 5425.779943385774, 5511.421300763443, 5556.91664625031, 5587.888242235133, 976.0971101731012, 984.4290311619387, 988.1205726903062, 996.0985308296003, 1000.9449480278508, 22063.0, 22144.2249521266, 22621.321360359216, 22939.541209175724, 23440.17959371414, 1075.231209685079, 1081.561967403203, 1084.2572837606265, 1087.4671411008708, 1139.3448766959032, 11556.711082223012, 11791.469383877746, 11795.705107372212, 12244.81632775509, 12462.5014999399, 193801.0, 195255.0, 195853.0, 196412.0, 196737.0, 45859.77070114628, 46471.767641161576, 46689.29966050512, 46996.0, 47003.0, 1377.6349267444136, 1432.1621851216946, 1437.8274607047013, 1445.6530432696288, 1449.9420023199166, 20663.276785312442, 21167.0, 22606.0, 22853.08587656475, 22863.027806385064, 33906.83046584751, 33913.49129763105, 33925.3214935695, 33951.49072763861, 34147.0, 170786.0, 171998.14000929915, 172425.0, 172648.13675932042, 173025.13487432984, 30482.84758576193, 30493.847530762203, 30646.387072258876, 32551.0, 32567.837160814994, 40988.0, 41991.58008419999, 42005.36991945184, 42061.789691052574, 42532.1493570133, 28589.28526786847, 30278.0, 30462.695373046874, 30997.535036974914, 32088.358232834744, 29443.85278073596, 29748.405031899674, 30112.397752045275, 30427.0, 30892.691073088983, 33680.0, 34428.655713442546, 35552.46671299984, 35567.64432355644, 35899.28201435904, 28849.85575072111, 29320.853395732884, 29721.851390742908, 30374.69625303807, 31692.0, 23201.767982320634, 24139.0, 24414.75585244125, 24748.50502989966, 24921.875390622932], "value": 15968.36790313117, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.8606473798908, 421.5992986120759, 428.5585846578024, 440.51763319165514, 441.3313829548233, 14678.192699401528, 15150.090994540335, 20516.589668206627, 21192.576148477023, 21196.576068478622, 21804.563908721815, 22501.0, 22532.54934901301, 22600.88699556504, 22624.8868755656, 5895.056790913444, 6005.4895333896675, 6067.817965461043, 6070.635761854281, 6074.51403887688, 5896.204012458306, 5935.0, 5944.316403613597, 5975.223220981266, 5986.461218490335, 5710.371859095496, 5740.7703691852275, 5753.827385178431, 5935.73289201987, 5951.285845698522, 5791.247137872092, 5798.275215598051, 5848.912266316009, 5861.765529378862, 5862.443067908542, 5257.263983042377, 5265.210218467222, 5281.207818827168, 5283.841484755463, 5292.52367286946, 24225.0, 24501.63247551288, 24523.509529809482, 24573.38566535833, 24573.38566535851, 1891.3758459708401, 1906.3518403742655, 1913.5120544261263, 1920.6062757134753, 1921.3851567498407, 14399.0, 16349.673006539922, 16375.59061023472, 16431.753523697153, 16436.260368283456, 2195.9890200548894, 2197.9340619781433, 2262.6379779235244, 2265.682804407384, 2268.5236100418933, 108224.0, 110639.0, 111043.88956110417, 111189.0, 111277.44361278223, 10602.36385816838, 11443.885561144281, 11459.77080458386, 11643.126765492621, 11767.176297659253, 16235.512934611981, 16274.837251627332, 16287.104209268604, 16318.75521867173, 16348.264328105264, 8524.147585241426, 8537.932758405199, 8550.674645429968, 8551.444156129832, 8692.478451292942, 8075.3539716822515, 8123.593820308961, 8172.141925097898, 8174.877376839352, 8223.0, 7181.533200341961, 7353.852922941511, 7376.926230737731, 7408.259174082548, 7421.925780742232, 2082.6251274770384, 2095.3818623506104, 2100.6008858316873, 2116.9364919052455, 2226.743924448677, 935.7988032572894, 979.1303659116093, 979.9853002204973, 984.6110786239395, 992.9255305851946, 18240.087995600166, 19177.616447671247, 19344.806551934584, 19373.225070997283, 19408.61182776365, 944.9291303152291, 973.9464329461948, 1005.9899401006043, 1013.7110923386799, 1041.2974786224577, 10176.575279460882, 10308.484575771181, 10311.175105991502, 10587.364758114538, 10634.627788027381, 416299.0, 419755.0, 420964.0, 435295.0, 437863.0, 95029.0, 96224.0, 96301.0, 96714.0, 97039.0, 1146.7018575170348, 1160.4371879638368, 1168.199783148546, 1178.0398974835653, 1183.0, 15989.802039591896, 16277.953834311402, 16853.0, 16913.23890424909, 18014.2794288227, 46274.53725462837, 46593.76703116463, 47897.281540777614, 48330.275045873634, 48532.757336214505, 59340.0, 59425.405745941986, 59592.167292398, 59746.103808442036, 59833.70083149557, 9842.21262299, 10074.19406447497, 10090.19278457707, 10111.191104711752, 10135.0, 16453.341866325693, 17223.7416438756, 17977.022527522222, 18035.368762093265, 18185.09074546241, 12935.611931642066, 13805.17168969865, 13841.577723898075, 13842.584722458343, 14031.579052628438, 12999.870001299865, 13157.53948611794, 13231.206127632373, 13484.528041518499, 13672.179669219879, 15261.389544418098, 15268.083914965138, 15268.160251186291, 15420.9228953859, 15425.614359641098, 10066.993300670167, 10241.641542546273, 10249.33379330341, 10316.793664126526, 10336.689899303034, 13531.0, 13890.722185556435, 14048.227347495986, 14478.972943788089, 14672.633184170481], "value": 10083.559033193033, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.4562311017814, 1331.7269959658272, 1337.2578219088402, 1339.9866001339988, 1341.885939695127, 10881.727956801084, 11221.214514983954, 11423.828642570368, 11443.084553235742, 11494.770104597903, 11280.887191128086, 11435.313881167136, 11476.598319058834, 11507.07943364531, 11510.366929818856, 2338.1582630253097, 2403.9302510382886, 2404.675368825204, 2405.302462285935, 2418.903243870243, 2237.6196046672103, 2331.895064722092, 2410.650455683925, 2427.3446169534213, 2437.293184976355, 2394.090245706629, 2418.5525677749583, 2456.2140115163156, 2457.8771061446855, 2468.3705655058025, 2382.976170238293, 2383.4994651123197, 2386.9880650596724, 2390.378501589582, 2392.557376885282, 2314.3866875278063, 2341.6019276723, 2353.470469144446, 2362.5393048355577, 2362.8227882908677, 10771.030607245308, 10951.397673127974, 10971.506282217319, 10989.725256868562, 11017.228793984425, 6099.48154406876, 6287.52843536732, 6301.747930082791, 6308.053791931201, 6309.116723658692, 3591.2637909228806, 3842.8654997075246, 3914.6476817086314, 3935.3506671399186, 3942.664873485757, 1350.2303686898472, 1354.7222819322014, 1392.3595146232744, 1397.7553928062548, 1410.781328894023, 14148.92925535376, 14655.63360915975, 16273.83726162735, 16337.26482308299, 16340.34638614454, 5237.083510385667, 5420.647657902224, 5431.429699881455, 5447.509724124769, 5452.154915988028, 12206.938965305295, 12268.38658067111, 12319.076069294839, 12349.19730217533, 12364.56724014655, 6300.338464461257, 6351.174347334817, 6366.9681651591445, 6368.426841584187, 6369.681515924185, 5847.9415205848245, 6003.0695242237525, 6033.78881739137, 6034.853377858193, 6050.606710563799, 4032.4306568252773, 4130.215259100822, 4139.2043198602305, 4151.418801367811, 4216.47294088239, 1102.090775110537, 1114.2367478277406, 1123.4831977290537, 1128.836318733779, 1128.8476055732372, 827.9337652987747, 857.4598003258033, 860.655737704923, 867.6659486097772, 895.6417433026711, 5806.2451881255165, 5908.940910590925, 6020.69896505173, 6106.4809491192855, 6200.441960223601, 944.390867890207, 986.9932668677908, 987.111599560387, 991.0881988570533, 992.593036854886, 4545.2954792007295, 4691.296305554194, 4701.318308845198, 4809.254565542346, 4979.950200497949, 13845.100068495516, 14259.643508912153, 14269.714605707828, 14298.785518217235, 14396.856031439762, 13659.931700341434, 13866.791998120036, 14102.083364581269, 14295.714085718228, 14312.57062288133, 8891.46651200917, 9063.637454501746, 9103.635854565875, 9104.681336153202, 9112.681056163136, 6522.673866306761, 6616.735330586916, 6925.3074692530345, 7021.754238601625, 7260.491765576359, 12661.366931653196, 12716.74566508646, 12791.808122877977, 12903.225806451643, 12980.0, 11602.535898563963, 12774.169678970837, 13289.86710132925, 13321.866781332063, 13371.130876492996, 8762.430442021248, 8835.734927952171, 8931.508767017876, 8963.372563920462, 8978.236849867835, 10414.583416663248, 10601.204909631655, 10618.8407173894, 10643.733906652396, 10729.0, 8859.645614175619, 8968.148025937526, 8988.955055224944, 9073.364864459689, 9219.354645174773, 8570.271526920282, 8580.613872375883, 8663.870041949249, 8683.782905427162, 8746.91253087461, 7935.801604959922, 8104.594770261581, 8131.634076466691, 8158.4289099762445, 8168.142345053684, 5675.687837168995, 5847.06446968483, 6007.789727359696, 6060.878782424415, 6169.660668663087, 6185.597936134137, 6307.495400368051, 6349.555531112963, 6500.674966251574, 6682.899756503753], "value": 5273.334161005273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.90594304395427, 404.72680940365257, 405.5336363182342, 406.05591998603245, 406.3072461453221, 6218.62688238706, 6363.236411630599, 6367.586106903048, 6376.234851817777, 6426.325235850232, 6076.513878889689, 6135.570510064297, 6147.262328520584, 6172.567920245585, 6173.0, 4788.9521104788855, 4810.254410566367, 4814.3019262207135, 4818.9036219275595, 4827.03459308138, 4802.399700037496, 4826.420829500465, 4827.082854257697, 4836.15367310721, 4859.951400485986, 4784.162771514988, 4790.808367665307, 4795.832145874895, 4802.0, 4803.831865884695, 4767.690100143514, 4774.188387974053, 4783.497732738065, 4784.330193772875, 4808.682009413528, 4181.770002649853, 4190.036291652907, 4194.140201258765, 4196.874093777192, 4206.0, 6113.84258704081, 6128.3565225651555, 6158.322584515699, 6177.517395825014, 6191.133241346215, 5507.7246137693355, 5510.393856675802, 5514.448555144493, 5520.447955204448, 5523.861903452405, 6531.706073226716, 6558.8360290993105, 6572.6667033203485, 6582.736690532373, 6597.274299827015, 4553.772311384418, 4560.8859778505475, 4566.54334566544, 4567.451905771329, 4577.8397756078375, 6563.5888284019165, 6663.400293973517, 6801.803152518309, 6931.68807403663, 7039.190493093309, 4566.840160594364, 4604.2964103282, 4614.123316569841, 4628.514006029386, 4660.627149828006, 4674.0, 4699.882502937454, 4700.811967521261, 4705.0, 4718.787654555554, 5325.254464374991, 5416.539594134542, 5435.130379139318, 5443.319585051869, 5472.226800725273, 6557.180352455943, 6601.207855057424, 6629.105070815378, 6630.336966303427, 6634.23706273775, 1629.2994012574707, 1631.6981358448725, 1632.7469242267468, 1637.7379619260862, 1641.433705371645, 1061.994690026545, 1093.9343639381664, 1095.59462998691, 1102.2504696806088, 1102.3826657072066, 5870.882582348329, 5879.941200588025, 5905.970470147708, 5919.526437884959, 5923.851903702442, 6775.186977562724, 6807.319268073153, 6849.657517124124, 6850.520463567503, 6854.383105520527, 5816.720321529257, 5851.941480585225, 5880.705964701748, 5897.616654917417, 5903.498202652737, 3609.8917032489067, 3615.6022837487853, 3620.153721601949, 3625.510556074949, 3657.3965295725907, 6532.738690452424, 6579.80260592183, 6595.604263744191, 6600.471962243009, 6636.203655561363, 6967.965160174167, 6972.721091156297, 6991.720331186695, 6992.475564332593, 7005.92994070063, 6550.410463058348, 6584.308647591934, 6591.978243372285, 6592.571482853599, 6616.603003819786, 6829.385355318045, 6834.829129271609, 6840.692168852314, 6841.692123854538, 6887.793366199022, 6730.259671436236, 6756.898646520208, 6774.288699686462, 6774.559653622498, 6795.762148324785, 6228.190335256388, 6575.736970521126, 6581.243157037002, 6586.407223349922, 6588.40704336612, 4574.0, 4589.5639914208095, 4603.171429142786, 4607.424071991001, 4624.531601299026, 6761.560498567577, 6766.594004359557, 6780.254172040973, 6844.794656160323, 6847.0, 6403.6157830528455, 6608.867822643617, 6622.37087476689, 6622.841002824583, 6677.432418244503, 6611.570247933869, 6654.334566543501, 6667.633280169637, 6673.866522669422, 6677.732890684512, 6518.706658200297, 6527.11883895687, 6552.985626611812, 6561.311062338385, 6580.934190658032, 6640.0, 6646.8005959821285, 6673.0, 6680.331966803476, 6730.93269067303, 6483.286838447862, 6504.544681872224, 6511.576747511396, 6513.316101809241, 6527.0], "value": 4952.1515072715665, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.0800357601277, 840.4327079221525, 850.1201256699318, 856.4861083349991, 869.4739682492094, 14689.0, 15288.0, 16231.26959286832, 16787.83212167878, 16808.747868781946, 17457.563560910985, 17636.0, 17993.280268789233, 18079.276828926828, 18159.273629054824, 944.5466176235411, 971.4996776660025, 975.1564896364664, 975.1662328708958, 977.9315447918649, 925.8750068740735, 961.1157734883924, 965.7826988927505, 966.1063516247478, 967.0281367225963, 1019.7246743379283, 1029.5881647341048, 1029.9227557933184, 1029.9742506437324, 1031.1338475680427, 1024.165305276205, 1024.733569271987, 1024.861643678105, 1026.563710423071, 1028.5371582787739, 751.7406494759299, 754.977350679475, 755.5768769489104, 755.8639444899916, 756.4364548411469, 16932.576685582837, 17105.91447042769, 17197.0, 17359.826401735947, 17494.737578936325, 18387.72418413725, 18604.44186674402, 18723.906380468146, 18770.624587508173, 18949.526261843428, 13379.397927093305, 13950.51173208943, 13953.441862325495, 13960.371783269777, 13968.58094257174, 3461.394256005189, 3512.59605145409, 3518.9120271993147, 3520.7887526748223, 3526.2418580005424, 97499.0, 98068.50965745126, 99426.50286748592, 99470.53441526278, 101544.0, 14952.028118172284, 14969.101853888802, 15091.54725358241, 15210.391584336723, 15279.312430940634, 27290.590641140003, 28210.576841347396, 28429.715702842706, 28577.428451430857, 28634.856825716153, 7991.480553763987, 8088.433809633387, 8477.872831907527, 8487.0, 8493.278071364004, 3936.2324346752107, 4004.5594984551676, 4030.274550580865, 4041.333180025322, 4046.0289530513055, 4008.4388185654034, 4115.34154535273, 4136.193442278727, 4137.213929353413, 4265.786710664516, 849.9575021248913, 852.8912413861955, 858.6565373850385, 864.8616221404545, 864.9135086491301, 660.9834754131185, 691.9965400172966, 694.3334398977039, 696.1785093589613, 705.8835292176733, 10280.228982826318, 10979.39613321275, 11006.064484518745, 11787.174897757246, 12358.876411235773, 684.8801459744525, 687.3092541995263, 690.702997710979, 692.5256199503357, 707.1231672725783, 5126.179811230185, 5182.140436590908, 5296.285001524822, 5322.707251101149, 5356.839294821161, 90012.54993724989, 91472.0, 91858.0, 92325.53837230771, 93761.5311923436, 80589.59705201554, 81671.0, 82150.0, 82445.17554824495, 82968.17031829726, 68824.31175688178, 69689.0, 70513.94229086569, 70670.2932970674, 71427.0, 10195.490225488844, 10274.640387586398, 10384.896151038392, 10817.296875703054, 11188.88811111911, 29973.250668733457, 31068.0, 31330.0, 31399.52900706537, 31861.840690796398, 40075.0, 40225.0, 40376.39435408413, 40426.59573404228, 40950.9762255946, 14630.487932922297, 14934.55196344068, 15135.924320378328, 15186.544403667907, 15314.540563783105, 15723.0, 16593.75109373336, 17773.20020599102, 18312.542186445444, 18450.0, 15725.292361843516, 15797.526074217792, 15849.494298041667, 16100.355985760438, 16193.02841829494, 15571.922140389226, 15631.765523517384, 15834.683306333578, 15896.284667190235, 16229.350825966829, 15701.528954131394, 17002.06488643087, 17104.82895171082, 17124.743128853326, 17389.47831565055, 9877.703668889944, 10458.58165673395, 10519.94740026295, 10754.408507531847, 10822.621208257673, 11492.253003554742, 11845.52617895309, 12122.27266364021, 12130.090243231969, 12306.630801075982], "value": 8041.732493066897, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 110.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 123.0, 168.0, 121.0, 120.0, 121.0, 122.0, 146.0, 121.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 161.0, 163.0, 164.0, 165.0, 171.0, 167.0, 169.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 119.0, 74.0, 75.0, 75.0, 75.0, 99.0, 73.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 107.0, 83.0, 81.0, 82.0, 108.0, 83.0, 82.0, 101.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 124.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 153.0, 154.0, 154.0, 153.0, 149.0, 150.0, 149.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 55.0, 58.0, 55.0, 58.0, 56.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 87.0, 84.0, 85.0, 85.0, 86.0, 87.0, 87.0, 106.0, 96.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 136.0, 132.0, 146.0, 131.0, 128.0, 132.0, 131.0, 132.0, 134.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 193.0, 193.0, 195.0, 204.0, 202.0, 208.0, 195.0, 193.0, 192.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 72.0, 71.0, 74.0, 72.0, 70.0, 76.0, 70.0, 70.0], "value": 71.9, "unit": "score"}]}]} 02:55:19 INFO - Return code: 0 02:55:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:55:19 INFO - # TBPL SUCCESS # 02:55:19 INFO - Running post-action listener: _resource_record_post_action 02:55:19 INFO - [mozharness: 2017-06-05 09:55:19.142784Z] Finished run-tests step (success) 02:55:19 INFO - Running post-run listener: _resource_record_post_run 02:55:19 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 4096; Write bytes: 423698432; Read time: 8; Write time: 217576 02:55:19 INFO - TinderboxPrint: CPU usage
12.7% 02:55:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:55:19 INFO - TinderboxPrint: I/O write bytes / time
423,698,432 / 217,576 02:55:19 INFO - TinderboxPrint: CPU idle
8,726.7 (87.3%) 02:55:19 INFO - TinderboxPrint: CPU user
1,210.8 (12.1%) 02:55:19 INFO - TinderboxPrint: Swap in / out
0 / 0 02:55:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 101847040; Read time: 0; Write time: 74988 02:55:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:55:19 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 321851392; Read time: 0; Write time: 142588 02:55:19 INFO - Running post-run listener: _upload_blobber_files 02:55:19 INFO - Blob upload gear active. 02:55:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55: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 02:55: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'] 02:55: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 02:55:20 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:55:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:21 INFO - (blobuploader) - INFO - Done attempting. 02:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:21 INFO - (blobuploader) - INFO - Done attempting. 02:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:22 INFO - (blobuploader) - INFO - Done attempting. 02:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:29 INFO - (blobuploader) - INFO - Done attempting. 02:55:29 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:29 INFO - Return code: 0 02:55:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1787b75d9e0635b2d4e5fba5e9b5e04f45cb1211cc8bac6cc76c7a6d64bbbdd92343397e067b459bdb5ffff967777f7500f45704e7103e718462c3f07c1b7432", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88ad0f0bb1c9bbb483a156d28c221ec8c66242cfdf16ff5392d0e7c25372b3f89451469fc8c7420c12d7874a3d7db87d0f0f2f3424824d2331300c91b4a46100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9b2326c45e90aa28cf0b48874a82e83ed6ef5753c2e7120b77615331b8c59ad8d78a50855f3f49dc2a2581b21f05c0ab14511047373a66b4efadd99642bef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea5e50fe2ebc9f1ef286f7669f191572f55ad360d554b50993315199df8630f471cb0dabebe1b7de872a95a9f4cec9694ab147a6d57331d28f9465f1d4f39070"} 02:55:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:29 INFO - Contents: 02:55:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1787b75d9e0635b2d4e5fba5e9b5e04f45cb1211cc8bac6cc76c7a6d64bbbdd92343397e067b459bdb5ffff967777f7500f45704e7103e718462c3f07c1b7432", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88ad0f0bb1c9bbb483a156d28c221ec8c66242cfdf16ff5392d0e7c25372b3f89451469fc8c7420c12d7874a3d7db87d0f0f2f3424824d2331300c91b4a46100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9b2326c45e90aa28cf0b48874a82e83ed6ef5753c2e7120b77615331b8c59ad8d78a50855f3f49dc2a2581b21f05c0ab14511047373a66b4efadd99642bef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea5e50fe2ebc9f1ef286f7669f191572f55ad360d554b50993315199df8630f471cb0dabebe1b7de872a95a9f4cec9694ab147a6d57331d28f9465f1d4f39070"} 02:55:29 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:29 INFO - Copying logs to upload dir... 02:55:29 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.378150 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-05 02:55:28.360033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 02:55:28.364090) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1787b75d9e0635b2d4e5fba5e9b5e04f45cb1211cc8bac6cc76c7a6d64bbbdd92343397e067b459bdb5ffff967777f7500f45704e7103e718462c3f07c1b7432", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88ad0f0bb1c9bbb483a156d28c221ec8c66242cfdf16ff5392d0e7c25372b3f89451469fc8c7420c12d7874a3d7db87d0f0f2f3424824d2331300c91b4a46100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9b2326c45e90aa28cf0b48874a82e83ed6ef5753c2e7120b77615331b8c59ad8d78a50855f3f49dc2a2581b21f05c0ab14511047373a66b4efadd99642bef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea5e50fe2ebc9f1ef286f7669f191572f55ad360d554b50993315199df8630f471cb0dabebe1b7de872a95a9f4cec9694ab147a6d57331d28f9465f1d4f39070"} build_url:https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/YIj7ffE3QgOo8lwBgNwUag/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1787b75d9e0635b2d4e5fba5e9b5e04f45cb1211cc8bac6cc76c7a6d64bbbdd92343397e067b459bdb5ffff967777f7500f45704e7103e718462c3f07c1b7432", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/88ad0f0bb1c9bbb483a156d28c221ec8c66242cfdf16ff5392d0e7c25372b3f89451469fc8c7420c12d7874a3d7db87d0f0f2f3424824d2331300c91b4a46100", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9c9b2326c45e90aa28cf0b48874a82e83ed6ef5753c2e7120b77615331b8c59ad8d78a50855f3f49dc2a2581b21f05c0ab14511047373a66b4efadd99642bef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea5e50fe2ebc9f1ef286f7669f191572f55ad360d554b50993315199df8630f471cb0dabebe1b7de872a95a9f4cec9694ab147a6d57331d28f9465f1d4f39070"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 02:55:28.388624) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:55:28.388982) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1496652233.994045-609280570 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:55:28.472881) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 02:55:28.473198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 02:55:28.473488) ========= ========= Total master_lag: 0.20 =========