builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1495426338.6 results: success (0) revision: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:18.602550) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:18.602956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:18.603588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:18.641198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:18.641467) ========= 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=17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-21 21:12:18-- 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% 220M=0s 2017-05-21 21:12:19 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.363407 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:19.018275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:19.021608) ========= 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=17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019833 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:19.074771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:19.075123) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 --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 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 --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=17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-21 21:12:19,250 truncating revision to first 12 chars 2017-05-21 21:12:19,250 Setting DEBUG logging. 2017-05-21 21:12:19,250 attempt 1/10 2017-05-21 21:12:19,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9851fcb0bf4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-21 21:12:19,895 unpacking tar archive at: mozilla-central-9851fcb0bf4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.953951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:20.040853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:20.041124) ========= script_repo_revision: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:20.041475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:20.044780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 21:12:20.053136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-21 21:12:20.053411) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:12:20 INFO - MultiFileLogger online at 20170521 21:12:20 in /builds/slave/test 21:12:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:12:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:20 INFO - {'append_to_log': False, 21:12:20 INFO - 'base_work_dir': '/builds/slave/test', 21:12:20 INFO - 'blob_upload_branch': 'Firefox', 21:12:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:20 INFO - 'branch': 'Firefox', 21:12:20 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:20 INFO - 'config_files': ('talos/linux_config.py',), 21:12:20 INFO - 'default_actions': ('clobber', 21:12:20 INFO - 'read-buildbot-config', 21:12:20 INFO - 'download-and-extract', 21:12:20 INFO - 'populate-webroot', 21:12:20 INFO - 'create-virtualenv', 21:12:20 INFO - 'install', 21:12:20 INFO - 'run-tests'), 21:12:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:20 INFO - 'download_minidump_stackwalk': True, 21:12:20 INFO - 'download_symbols': 'ondemand', 21:12:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:20 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:20 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:20 INFO - 'gecko_profile': False, 21:12:20 INFO - 'gecko_profile_interval': 0, 21:12:20 INFO - 'installer_path': 'installer.exe', 21:12:20 INFO - 'log_level': 'info', 21:12:20 INFO - 'log_name': 'talos', 21:12:20 INFO - 'log_to_console': True, 21:12:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:12:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:12:20 INFO - 'opt_config_files': (), 21:12:20 INFO - 'pip_index': False, 21:12:20 INFO - 'suite': 'dromaeojs-e10s', 21:12:20 INFO - 'system_bits': '32', 21:12:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:20 INFO - 'title': 'talos-linux64-ix-009', 21:12:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:20 INFO - 'use_talos_json': True, 21:12:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:20 INFO - 'work_dir': 'build'} 21:12:20 INFO - [mozharness: 2017-05-22 04:12:20.333421Z] Running clobber step. 21:12:20 INFO - Running pre-action listener: _resource_record_pre_action 21:12:20 INFO - Running main action method: clobber 21:12:20 INFO - rmtree: /builds/slave/test/build 21:12:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:21 INFO - Running post-action listener: _resource_record_post_action 21:12:21 INFO - [mozharness: 2017-05-22 04:12:21.465755Z] Finished clobber step (success) 21:12:21 INFO - [mozharness: 2017-05-22 04:12:21.465857Z] Running read-buildbot-config step. 21:12:21 INFO - Running pre-action listener: _resource_record_pre_action 21:12:21 INFO - Running main action method: read_buildbot_config 21:12:21 INFO - Using buildbot properties: 21:12:21 INFO - { 21:12:21 INFO - "project": "", 21:12:21 INFO - "product": "firefox", 21:12:21 INFO - "who": "ihsiao@mozilla.com", 21:12:21 INFO - "installer_path": "public/build/target.tar.bz2", 21:12:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 21:12:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:12:21 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 21:12:21 INFO - "stage_platform": "linux64-stylosequential", 21:12:21 INFO - "basedir": "/builds/slave/test", 21:12:21 INFO - "buildnumber": 11, 21:12:21 INFO - "platform": "ubuntu64_hw_styloseq", 21:12:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:12:21 INFO - "slavebuilddir": "test", 21:12:21 INFO - "taskId": "Qdw7coziR4mHcQQ5_JzwTw", 21:12:21 INFO - "branch": "mozilla-central", 21:12:21 INFO - "script_repo_revision": "production", 21:12:21 INFO - "revision": "9851fcb0bf4d855c36729d7de19f0fa5c9f69776", 21:12:21 INFO - "slavename": "talos-linux64-ix-009", 21:12:21 INFO - "repo_path": "mozilla-central" 21:12:21 INFO - } 21:12:21 INFO - Finding installer, test and symbols from parent task. 21:12:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qdw7coziR4mHcQQ5_JzwTw'}, attempt #1 21:12:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qdw7coziR4mHcQQ5_JzwTw'}, attempt #1 21:12:22 INFO - Task dependencies: CloPmkbsR3-4P0-9HKO0qg 21:12:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg'}, attempt #1 21:12:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2 21:12:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/test_packages.json 21:12:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.crashreporter-symbols.zip 21:12:22 INFO - Running post-action listener: _resource_record_post_action 21:12:22 INFO - [mozharness: 2017-05-22 04:12:22.840382Z] Finished read-buildbot-config step (success) 21:12:22 INFO - [mozharness: 2017-05-22 04:12:22.840603Z] Running download-and-extract step. 21:12:22 INFO - Running pre-action listener: _resource_record_pre_action 21:12:22 INFO - Running main action method: download_and_extract 21:12:22 INFO - mkdir: /builds/slave/test/build/tests 21:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:22 INFO - trying https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.test_packages.json 21:12:22 INFO - Downloading https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:12:23 INFO - Downloaded 986 bytes. 21:12:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:12:23 INFO - Using the following test package requirements: 21:12:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:12:23 INFO - u'common': [u'target.common.tests.zip'], 21:12:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:12:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:12:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:12:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:12:23 INFO - u'mozbase': [u'target.common.tests.zip'], 21:12:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:12:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:12:23 INFO - u'web-platform': [u'target.common.tests.zip', 21:12:23 INFO - u'target.web-platform.tests.zip'], 21:12:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:12:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:12:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.common.tests.zip 21:12:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:12:23 INFO - Fetch https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.common.tests.zip into memory 21:12:25 INFO - Content-Length response header: 63520804 21:12:25 INFO - Bytes received: 63520804 21:12:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:12:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.common.tests.zip 21:12:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:12:35 INFO - Fetch https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.common.tests.zip into memory 21:12:37 INFO - Content-Length response header: 63520804 21:12:37 INFO - Bytes received: 63520804 21:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.talos.tests.zip 21:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.talos.tests.zip into memory 21:12:51 INFO - Content-Length response header: 14410000 21:12:51 INFO - Bytes received: 14410000 21:12:52 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')]} 21:12:52 INFO - trying https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2 21:12:52 INFO - Downloading https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:12:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:12:53 INFO - Downloaded 56500771 bytes. 21:12:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2 21:12:53 INFO - mkdir: /builds/slave/test/properties 21:12:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:12:53 INFO - Writing to file /builds/slave/test/properties/build_url 21:12:53 INFO - Contents: 21:12:53 INFO - build_url:https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2 21:12:53 INFO - Running post-action listener: _resource_record_post_action 21:12:53 INFO - Running post-action listener: set_extra_try_arguments 21:12:53 INFO - [mozharness: 2017-05-22 04:12:53.130665Z] Finished download-and-extract step (success) 21:12:53 INFO - [mozharness: 2017-05-22 04:12:53.130763Z] Running populate-webroot step. 21:12:53 INFO - Running pre-action listener: _resource_record_pre_action 21:12:53 INFO - Running main action method: populate_webroot 21:12:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:12:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:12:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:12:53 INFO - '--tppagecycles', 21:12:53 INFO - '7'], 21:12:53 INFO - 'tests': ['tsvgm']}}, 21:12:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:12:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:12:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:12:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:12:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:12:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:12:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['damp', 'tps']}, 21:12:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'tests': ['damp', 'tps']}, 21:12:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['dromaeo_dom']}, 21:12:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:12:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:12:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:12:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'tests': ['ts_paint', 'tp5o']}, 21:12:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['a11yr', 21:12:53 INFO - 'ts_paint', 21:12:53 INFO - 'tpaint', 21:12:53 INFO - 'sessionrestore', 21:12:53 INFO - 'sessionrestore_no_auto_restore', 21:12:53 INFO - 'tabpaint']}, 21:12:53 INFO - 'other-e10s': {'tests': ['a11yr', 21:12:53 INFO - 'ts_paint', 21:12:53 INFO - 'tpaint', 21:12:53 INFO - 'sessionrestore', 21:12:53 INFO - 'sessionrestore_no_auto_restore', 21:12:53 INFO - 'tabpaint']}, 21:12:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:12:53 INFO - 'ts_paint', 21:12:53 INFO - 'tpaint', 21:12:53 INFO - 'sessionrestore', 21:12:53 INFO - 'sessionrestore_no_auto_restore', 21:12:53 INFO - 'tabpaint']}, 21:12:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:12:53 INFO - 'ts_paint', 21:12:53 INFO - 'tpaint', 21:12:53 INFO - 'sessionrestore', 21:12:53 INFO - 'sessionrestore_no_auto_restore', 21:12:53 INFO - 'tabpaint']}, 21:12:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['a11yr', 21:12:53 INFO - 'ts_paint', 21:12:53 INFO - 'tpaint', 21:12:53 INFO - 'sessionrestore', 21:12:53 INFO - 'sessionrestore_no_auto_restore', 21:12:53 INFO - 'tabpaint']}, 21:12:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['a11yr', 21:12:53 INFO - 'ts_paint', 21:12:53 INFO - 'tpaint', 21:12:53 INFO - 'sessionrestore', 21:12:53 INFO - 'sessionrestore_no_auto_restore', 21:12:53 INFO - 'tabpaint']}, 21:12:53 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:12:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:12:53 INFO - 'bloom_basic_ref']}, 21:12:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['tsvgx', 21:12:53 INFO - 'tsvgr_opacity', 21:12:53 INFO - 'tart', 21:12:53 INFO - 'tscrollx', 21:12:53 INFO - 'cart', 21:12:53 INFO - 'tsvg_static']}, 21:12:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:12:53 INFO - 'tsvgr_opacity', 21:12:53 INFO - 'tart', 21:12:53 INFO - 'tscrollx', 21:12:53 INFO - 'cart', 21:12:53 INFO - 'tsvg_static']}, 21:12:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'talos_options': ['--disable-e10s'], 21:12:53 INFO - 'tests': ['tp5o']}, 21:12:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:12:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'talos_options': ['--disable-e10s', 21:12:53 INFO - '--xperf_path', 21:12:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:12:53 INFO - 'tests': ['tp5n']}, 21:12:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:12:53 INFO - 'talos_options': ['--xperf_path', 21:12:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:12:53 INFO - 'tests': ['tp5n']}}, 21:12:53 INFO - 'talos.zip': {'path': '', 21:12:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:12:53 INFO - Running post-action listener: _resource_record_post_action 21:12:53 INFO - [mozharness: 2017-05-22 04:12:53.144729Z] Finished populate-webroot step (success) 21:12:53 INFO - [mozharness: 2017-05-22 04:12:53.144818Z] Running create-virtualenv step. 21:12:53 INFO - Running pre-action listener: _resource_record_pre_action 21:12:53 INFO - Running main action method: create_virtualenv 21:12:53 INFO - Creating virtualenv /builds/slave/test/build/venv 21:12:53 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 21:12:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:12:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:12:53 INFO - Using real prefix '/usr' 21:12:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:12:53 INFO - Installing distribute.............................................................................................................................................................................................done. 21:12:55 INFO - Installing pip.................done. 21:12:55 INFO - Return code: 0 21:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:12:55 INFO - Reading from file tmpfile_stdout 21:12:55 INFO - Output received: 21:12:55 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) 21:12:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:55 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:12:55 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 21:12:55 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 21:12:55 INFO - Using env: {'DISPLAY': ':0', 21:12:55 INFO - 'HOME': '/home/cltbld', 21:12:55 INFO - 'LANG': 'en_US.UTF-8', 21:12:55 INFO - 'LANGUAGE': 'en_US:en', 21:12:55 INFO - 'LOGNAME': 'cltbld', 21:12:55 INFO - 'MAIL': '/var/mail/cltbld', 21:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:55 INFO - 'MOZ_NO_REMOTE': '1', 21:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:55 INFO - 'NO_EM_RESTART': '1', 21:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:55 INFO - 'PWD': '/builds/slave/test', 21:12:55 INFO - 'SHELL': '/bin/bash', 21:12:55 INFO - 'SHLVL': '1', 21:12:55 INFO - 'TERM': 'linux', 21:12:55 INFO - 'TMOUT': '86400', 21:12:55 INFO - 'USER': 'cltbld', 21:12:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:55 INFO - '_': '/tools/buildbot/bin/python'} 21:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:56 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 21:12:56 INFO - Cleaning up... 21:12:56 INFO - Return code: 0 21:12:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:12:56 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')]} 21:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:56 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')]} 21:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:56 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:12:56 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 21:12:56 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 21:12:56 INFO - Using env: {'DISPLAY': ':0', 21:12:56 INFO - 'HOME': '/home/cltbld', 21:12:56 INFO - 'LANG': 'en_US.UTF-8', 21:12:56 INFO - 'LANGUAGE': 'en_US:en', 21:12:56 INFO - 'LOGNAME': 'cltbld', 21:12:56 INFO - 'MAIL': '/var/mail/cltbld', 21:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:56 INFO - 'MOZ_NO_REMOTE': '1', 21:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:56 INFO - 'NO_EM_RESTART': '1', 21:12:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:56 INFO - 'PWD': '/builds/slave/test', 21:12:56 INFO - 'SHELL': '/bin/bash', 21:12:56 INFO - 'SHLVL': '1', 21:12:56 INFO - 'TERM': 'linux', 21:12:56 INFO - 'TMOUT': '86400', 21:12:56 INFO - 'USER': 'cltbld', 21:12:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:56 INFO - '_': '/tools/buildbot/bin/python'} 21:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:56 INFO - Downloading/unpacking psutil>=3.1.1 21:12:56 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 21:12:56 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 21:12:56 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 21:12:56 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 21:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:12:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:12:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:12:57 INFO - Installing collected packages: psutil 21:12:57 INFO - Running setup.py install for psutil 21:12:57 INFO - building 'psutil._psutil_linux' extension 21:12:57 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 21:12:57 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 21:12:57 INFO - building 'psutil._psutil_posix' extension 21:12:57 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 21:12:57 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 21:12:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:12:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:12:58 INFO - Successfully installed psutil 21:12:58 INFO - Cleaning up... 21:12:58 INFO - Return code: 0 21:12:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:12:58 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')]} 21:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:58 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')]} 21:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:58 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:12:58 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 21:12:58 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 21:12:58 INFO - Using env: {'DISPLAY': ':0', 21:12:58 INFO - 'HOME': '/home/cltbld', 21:12:58 INFO - 'LANG': 'en_US.UTF-8', 21:12:58 INFO - 'LANGUAGE': 'en_US:en', 21:12:58 INFO - 'LOGNAME': 'cltbld', 21:12:58 INFO - 'MAIL': '/var/mail/cltbld', 21:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:58 INFO - 'MOZ_NO_REMOTE': '1', 21:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:58 INFO - 'NO_EM_RESTART': '1', 21:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:58 INFO - 'PWD': '/builds/slave/test', 21:12:58 INFO - 'SHELL': '/bin/bash', 21:12:58 INFO - 'SHLVL': '1', 21:12:58 INFO - 'TERM': 'linux', 21:12:58 INFO - 'TMOUT': '86400', 21:12:58 INFO - 'USER': 'cltbld', 21:12:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:58 INFO - '_': '/tools/buildbot/bin/python'} 21:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:12:58 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 21:12:58 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 21:12:58 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 21:12:58 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 21:12:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:12:59 INFO - Installing collected packages: mozsystemmonitor 21:12:59 INFO - Running setup.py install for mozsystemmonitor 21:12:59 INFO - Successfully installed mozsystemmonitor 21:12:59 INFO - Cleaning up... 21:12:59 INFO - Return code: 0 21:12:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:12:59 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')]} 21:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:12:59 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')]} 21:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:12:59 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:12:59 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 21:12:59 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 21:12:59 INFO - Using env: {'DISPLAY': ':0', 21:12:59 INFO - 'HOME': '/home/cltbld', 21:12:59 INFO - 'LANG': 'en_US.UTF-8', 21:12:59 INFO - 'LANGUAGE': 'en_US:en', 21:12:59 INFO - 'LOGNAME': 'cltbld', 21:12:59 INFO - 'MAIL': '/var/mail/cltbld', 21:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:12:59 INFO - 'MOZ_NO_REMOTE': '1', 21:12:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:12:59 INFO - 'NO_EM_RESTART': '1', 21:12:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:12:59 INFO - 'PWD': '/builds/slave/test', 21:12:59 INFO - 'SHELL': '/bin/bash', 21:12:59 INFO - 'SHLVL': '1', 21:12:59 INFO - 'TERM': 'linux', 21:12:59 INFO - 'TMOUT': '86400', 21:12:59 INFO - 'USER': 'cltbld', 21:12:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:12:59 INFO - '_': '/tools/buildbot/bin/python'} 21:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:12:59 INFO - Downloading/unpacking jsonschema==2.5.1 21:12:59 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 21:12:59 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 21:12:59 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 21:12:59 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 21:13:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:13:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:13:00 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 21:13:00 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 21:13:00 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 21:13:00 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 21:13:00 INFO - Downloading functools32-3.2.3-2.tar.gz 21:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:13:01 INFO - warning: no files found matching '*.txt' 21:13:01 INFO - no previously-included directories found matching 'build' 21:13:01 INFO - no previously-included directories found matching 'dist' 21:13:01 INFO - no previously-included directories found matching '.git*' 21:13:01 INFO - Installing collected packages: jsonschema, functools32 21:13:01 INFO - Running setup.py install for functools32 21:13:01 INFO - warning: no files found matching '*.txt' 21:13:01 INFO - no previously-included directories found matching 'build' 21:13:01 INFO - no previously-included directories found matching 'dist' 21:13:01 INFO - no previously-included directories found matching '.git*' 21:13:01 INFO - Successfully installed jsonschema functools32 21:13:01 INFO - Cleaning up... 21:13:01 INFO - Return code: 0 21:13:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:01 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:13:01 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 21:13:01 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 21:13:01 INFO - Using env: {'DISPLAY': ':0', 21:13:01 INFO - 'HOME': '/home/cltbld', 21:13:01 INFO - 'LANG': 'en_US.UTF-8', 21:13:01 INFO - 'LANGUAGE': 'en_US:en', 21:13:01 INFO - 'LOGNAME': 'cltbld', 21:13:01 INFO - 'MAIL': '/var/mail/cltbld', 21:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:01 INFO - 'MOZ_NO_REMOTE': '1', 21:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:01 INFO - 'NO_EM_RESTART': '1', 21:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:01 INFO - 'PWD': '/builds/slave/test', 21:13:01 INFO - 'SHELL': '/bin/bash', 21:13:01 INFO - 'SHLVL': '1', 21:13:01 INFO - 'TERM': 'linux', 21:13:01 INFO - 'TMOUT': '86400', 21:13:01 INFO - 'USER': 'cltbld', 21:13:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:01 INFO - '_': '/tools/buildbot/bin/python'} 21:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:13:01 INFO - Cleaning up... 21:13:01 INFO - Return code: 0 21:13:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:01 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:13:01 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 21:13:01 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 21:13:01 INFO - Using env: {'DISPLAY': ':0', 21:13:01 INFO - 'HOME': '/home/cltbld', 21:13:01 INFO - 'LANG': 'en_US.UTF-8', 21:13:01 INFO - 'LANGUAGE': 'en_US:en', 21:13:01 INFO - 'LOGNAME': 'cltbld', 21:13:01 INFO - 'MAIL': '/var/mail/cltbld', 21:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:01 INFO - 'MOZ_NO_REMOTE': '1', 21:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:01 INFO - 'NO_EM_RESTART': '1', 21:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:01 INFO - 'PWD': '/builds/slave/test', 21:13:01 INFO - 'SHELL': '/bin/bash', 21:13:01 INFO - 'SHLVL': '1', 21:13:01 INFO - 'TERM': 'linux', 21:13:01 INFO - 'TMOUT': '86400', 21:13:01 INFO - 'USER': 'cltbld', 21:13:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:01 INFO - '_': '/tools/buildbot/bin/python'} 21:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:01 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:01 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 21:13:01 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 21:13:01 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 21:13:01 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 21:13:02 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13:02 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 21:13:02 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 21:13:02 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 21:13:02 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 21:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13:03 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 21:13:03 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 21:13:03 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 21:13:03 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 21:13:03 INFO - Downloading docopt-0.6.1.tar.gz 21:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:03 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:03 INFO - Running setup.py install for blobuploader 21:13:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:03 INFO - Running setup.py install for requests 21:13:03 INFO - Running setup.py install for docopt 21:13:03 INFO - Successfully installed blobuploader requests docopt 21:13:03 INFO - Cleaning up... 21:13:03 INFO - Return code: 0 21:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:03 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')]} 21:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:03 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')]} 21:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:03 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:13:03 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 21:13:03 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 21:13:03 INFO - Using env: {'DISPLAY': ':0', 21:13:03 INFO - 'HOME': '/home/cltbld', 21:13:03 INFO - 'LANG': 'en_US.UTF-8', 21:13:03 INFO - 'LANGUAGE': 'en_US:en', 21:13:03 INFO - 'LOGNAME': 'cltbld', 21:13:03 INFO - 'MAIL': '/var/mail/cltbld', 21:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:03 INFO - 'MOZ_NO_REMOTE': '1', 21:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:03 INFO - 'NO_EM_RESTART': '1', 21:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:03 INFO - 'PWD': '/builds/slave/test', 21:13:03 INFO - 'SHELL': '/bin/bash', 21:13:03 INFO - 'SHLVL': '1', 21:13:03 INFO - 'TERM': 'linux', 21:13:03 INFO - 'TMOUT': '86400', 21:13:03 INFO - 'USER': 'cltbld', 21:13:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:03 INFO - '_': '/tools/buildbot/bin/python'} 21:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:04 INFO - Running setup.py (path:/tmp/pip-CqpZJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:04 INFO - Running setup.py (path:/tmp/pip-HiklM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:04 INFO - Running setup.py (path:/tmp/pip-b8yKT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:04 INFO - Running setup.py (path:/tmp/pip-BaisAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:04 INFO - Running setup.py (path:/tmp/pip-2YCPhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:04 INFO - Running setup.py (path:/tmp/pip-b_PXJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:04 INFO - Running setup.py (path:/tmp/pip-9Dotan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:04 INFO - Running setup.py (path:/tmp/pip-2Yc4Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:04 INFO - Running setup.py (path:/tmp/pip-ugLn8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:04 INFO - Running setup.py (path:/tmp/pip-46jp0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:04 INFO - Running setup.py (path:/tmp/pip-DJJ91n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:04 INFO - Running setup.py (path:/tmp/pip-urtKBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:04 INFO - Running setup.py (path:/tmp/pip-rdfPyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:05 INFO - Running setup.py (path:/tmp/pip-90BOyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:05 INFO - Running setup.py (path:/tmp/pip-CgXbHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:05 INFO - Running setup.py (path:/tmp/pip-QkOIun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:05 INFO - Running setup.py (path:/tmp/pip-VTfGHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:13:05 INFO - Running setup.py install for manifestparser 21:13:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:13:05 INFO - Running setup.py install for mozcrash 21:13:05 INFO - Running setup.py install for mozdebug 21:13:05 INFO - Running setup.py install for mozdevice 21:13:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:13:05 INFO - Running setup.py install for mozfile 21:13:05 INFO - Running setup.py install for mozhttpd 21:13:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:13:05 INFO - Running setup.py install for mozinfo 21:13:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Running setup.py install for mozInstall 21:13:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Running setup.py install for mozleak 21:13:06 INFO - Running setup.py install for mozlog 21:13:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Running setup.py install for moznetwork 21:13:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Running setup.py install for mozprocess 21:13:06 INFO - Running setup.py install for mozprofile 21:13:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Running setup.py install for mozrunner 21:13:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:13:06 INFO - Running setup.py install for mozscreenshot 21:13:06 INFO - Running setup.py install for moztest 21:13:06 INFO - Running setup.py install for mozversion 21:13:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:13:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:13:07 INFO - Cleaning up... 21:13:07 INFO - Return code: 0 21:13:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:07 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:13:07 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 21:13:07 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 21:13:07 INFO - Using env: {'DISPLAY': ':0', 21:13:07 INFO - 'HOME': '/home/cltbld', 21:13:07 INFO - 'LANG': 'en_US.UTF-8', 21:13:07 INFO - 'LANGUAGE': 'en_US:en', 21:13:07 INFO - 'LOGNAME': 'cltbld', 21:13:07 INFO - 'MAIL': '/var/mail/cltbld', 21:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:07 INFO - 'MOZ_NO_REMOTE': '1', 21:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:07 INFO - 'NO_EM_RESTART': '1', 21:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:07 INFO - 'PWD': '/builds/slave/test', 21:13:07 INFO - 'SHELL': '/bin/bash', 21:13:07 INFO - 'SHLVL': '1', 21:13:07 INFO - 'TERM': 'linux', 21:13:07 INFO - 'TMOUT': '86400', 21:13:07 INFO - 'USER': 'cltbld', 21:13:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:07 INFO - '_': '/tools/buildbot/bin/python'} 21:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:07 INFO - Running setup.py (path:/tmp/pip-HnEZzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:07 INFO - Running setup.py (path:/tmp/pip-xerWWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:07 INFO - Running setup.py (path:/tmp/pip-OhkZlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:07 INFO - Running setup.py (path:/tmp/pip-geywFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:07 INFO - Running setup.py (path:/tmp/pip-Zd5TlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:07 INFO - Running setup.py (path:/tmp/pip-sAsvUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:07 INFO - Running setup.py (path:/tmp/pip-vPVv16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:07 INFO - Running setup.py (path:/tmp/pip-7mo1ZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:07 INFO - Running setup.py (path:/tmp/pip-m0P3LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:07 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)) 21:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:07 INFO - Running setup.py (path:/tmp/pip-kEMWN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:08 INFO - Running setup.py (path:/tmp/pip-DqBSS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:08 INFO - Running setup.py (path:/tmp/pip-NPd25s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:08 INFO - Running setup.py (path:/tmp/pip-TSHM8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:08 INFO - Running setup.py (path:/tmp/pip-HZW4Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:08 INFO - Running setup.py (path:/tmp/pip-6TUwkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:08 INFO - Running setup.py (path:/tmp/pip-hTpJiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:08 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)) 21:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:08 INFO - Running setup.py (path:/tmp/pip-IwNOHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:08 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)) 21:13:08 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)) 21:13:08 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)) 21:13:08 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)) 21:13:08 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:08 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:08 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 21:13:08 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 21:13:08 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 21:13:08 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 21:13:09 INFO - Downloading blessings-1.6.tar.gz 21:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:13:09 INFO - Installing collected packages: blessings 21:13:09 INFO - Running setup.py install for blessings 21:13:09 INFO - Successfully installed blessings 21:13:09 INFO - Cleaning up... 21:13:09 INFO - Return code: 0 21:13:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:10 INFO - Reading from file tmpfile_stdout 21:13:10 INFO - Current package versions: 21:13:10 INFO - argparse == 1.2.1 21:13:10 INFO - blessings == 1.6 21:13:10 INFO - blobuploader == 1.2.4 21:13:10 INFO - docopt == 0.6.1 21:13:10 INFO - functools32 == 3.2.3-2 21:13:10 INFO - jsonschema == 2.5.1 21:13:10 INFO - manifestparser == 1.1 21:13:10 INFO - mozInstall == 1.12 21:13:10 INFO - mozcrash == 1.0 21:13:10 INFO - mozdebug == 0.1 21:13:10 INFO - mozdevice == 0.50 21:13:10 INFO - mozfile == 1.2 21:13:10 INFO - mozhttpd == 0.7 21:13:10 INFO - mozinfo == 0.9 21:13:10 INFO - mozleak == 0.1 21:13:10 INFO - mozlog == 3.4 21:13:10 INFO - moznetwork == 0.27 21:13:10 INFO - mozprocess == 0.25 21:13:10 INFO - mozprofile == 0.28 21:13:10 INFO - mozrunner == 6.13 21:13:10 INFO - mozscreenshot == 0.1 21:13:10 INFO - mozsystemmonitor == 0.3 21:13:10 INFO - moztest == 0.8 21:13:10 INFO - mozversion == 1.4 21:13:10 INFO - psutil == 3.1.1 21:13:10 INFO - requests == 1.2.3 21:13:10 INFO - wsgiref == 0.1.2 21:13:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13: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')]} 21:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:10 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 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:13:10 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 21:13:10 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 21:13:10 INFO - Using env: {'DISPLAY': ':0', 21:13:10 INFO - 'HOME': '/home/cltbld', 21:13:10 INFO - 'LANG': 'en_US.UTF-8', 21:13:10 INFO - 'LANGUAGE': 'en_US:en', 21:13:10 INFO - 'LOGNAME': 'cltbld', 21:13:10 INFO - 'MAIL': '/var/mail/cltbld', 21:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:10 INFO - 'MOZ_NO_REMOTE': '1', 21:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:10 INFO - 'NO_EM_RESTART': '1', 21:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:10 INFO - 'PWD': '/builds/slave/test', 21:13:10 INFO - 'SHELL': '/bin/bash', 21:13:10 INFO - 'SHLVL': '1', 21:13:10 INFO - 'TERM': 'linux', 21:13:10 INFO - 'TMOUT': '86400', 21:13:10 INFO - 'USER': 'cltbld', 21:13:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:10 INFO - '_': '/tools/buildbot/bin/python'} 21:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 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)) 21:13:10 INFO - Cleaning up... 21:13:10 INFO - Return code: 0 21:13:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13: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')]} 21:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a9a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, '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': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', '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 21:13: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', 'jsonschema'] in /builds/slave/test/build 21:13: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 jsonschema 21:13:10 INFO - Using env: {'DISPLAY': ':0', 21:13:10 INFO - 'HOME': '/home/cltbld', 21:13:10 INFO - 'LANG': 'en_US.UTF-8', 21:13:10 INFO - 'LANGUAGE': 'en_US:en', 21:13:10 INFO - 'LOGNAME': 'cltbld', 21:13:10 INFO - 'MAIL': '/var/mail/cltbld', 21:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:10 INFO - 'MOZ_NO_REMOTE': '1', 21:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:10 INFO - 'NO_EM_RESTART': '1', 21:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:10 INFO - 'PWD': '/builds/slave/test', 21:13:10 INFO - 'SHELL': '/bin/bash', 21:13:10 INFO - 'SHLVL': '1', 21:13:10 INFO - 'TERM': 'linux', 21:13:10 INFO - 'TMOUT': '86400', 21:13:10 INFO - 'USER': 'cltbld', 21:13:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:10 INFO - '_': '/tools/buildbot/bin/python'} 21:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:13:10 INFO - Cleaning up... 21:13:10 INFO - Return code: 0 21:13:10 INFO - Running post-action listener: _resource_record_post_action 21:13:10 INFO - Running post-action listener: _start_resource_monitoring 21:13:10 INFO - Starting resource monitoring. 21:13:10 INFO - [mozharness: 2017-05-22 04:13:10.565989Z] Finished create-virtualenv step (success) 21:13:10 INFO - [mozharness: 2017-05-22 04:13:10.566488Z] Running install step. 21:13:10 INFO - Running pre-action listener: _resource_record_pre_action 21:13:10 INFO - Running main action method: install 21:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:10 INFO - Reading from file tmpfile_stdout 21:13:10 INFO - Detecting whether we're running mozinstall >=1.0... 21:13:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:13:10 INFO - Reading from file tmpfile_stdout 21:13:10 INFO - Output received: 21:13:10 INFO - Usage: mozinstall [options] installer 21:13:10 INFO - Options: 21:13:10 INFO - -h, --help show this help message and exit 21:13:10 INFO - -d DEST, --destination=DEST 21:13:10 INFO - Directory to install application into. [default: 21:13:10 INFO - "/builds/slave/test"] 21:13:10 INFO - --app=APP Application being installed. [default: firefox] 21:13:10 INFO - mkdir: /builds/slave/test/build/application 21:13:10 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'] 21:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:13:26 INFO - Reading from file tmpfile_stdout 21:13:26 INFO - Output received: 21:13:26 INFO - /builds/slave/test/build/application/firefox/firefox 21:13:26 INFO - Running post-action listener: _resource_record_post_action 21:13:26 INFO - [mozharness: 2017-05-22 04:13:26.981179Z] Finished install step (success) 21:13:26 INFO - [mozharness: 2017-05-22 04:13:26.981462Z] Running run-tests step. 21:13:26 INFO - Running pre-action listener: _resource_record_pre_action 21:13:26 INFO - Running main action method: run_tests 21:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:13:26 INFO - Python 2.7.3 21:13:26 INFO - Return code: 0 21:13:26 INFO - grabbing minidump binary from tooltool 21:13: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')]} 21:13:26 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 0x1a977a0>, '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 0x1a986a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a98b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:13:26 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 21:13:26 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 21:13:26 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 21:13:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:13:27 INFO - Return code: 0 21:13:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:13:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:13:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:13:27 INFO - ENV: RUST_BACKTRACE is now 1 21:13:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:13:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 21:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 21:13:27 INFO - Using env: {'DISPLAY': ':0', 21:13:27 INFO - 'HOME': '/home/cltbld', 21:13:27 INFO - 'LANG': 'en_US.UTF-8', 21:13:27 INFO - 'LANGUAGE': 'en_US:en', 21:13:27 INFO - 'LOGNAME': 'cltbld', 21:13:27 INFO - 'MAIL': '/var/mail/cltbld', 21:13:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:13:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:27 INFO - 'MOZ_NO_REMOTE': '1', 21:13:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:13:27 INFO - 'NO_EM_RESTART': '1', 21:13:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:27 INFO - 'PWD': '/builds/slave/test', 21:13:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:13:27 INFO - 'RUST_BACKTRACE': '1', 21:13:27 INFO - 'SHELL': '/bin/bash', 21:13:27 INFO - 'SHLVL': '1', 21:13:27 INFO - 'TERM': 'linux', 21:13:27 INFO - 'TMOUT': '86400', 21:13:27 INFO - 'USER': 'cltbld', 21:13:27 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943', 21:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:27 INFO - '_': '/tools/buildbot/bin/python'} 21:13:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 21:13:27 INFO - mozversion application_buildid: 20170522033059 21:13:27 INFO - mozversion application_changeset: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 21:13:27 INFO - mozversion application_display_name: Nightly 21:13:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:13:27 INFO - mozversion application_name: Firefox 21:13:27 INFO - mozversion application_remotingname: firefox 21:13:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:13:27 INFO - mozversion application_vendor: Mozilla 21:13:27 INFO - mozversion application_version: 55.0a1 21:13:27 INFO - mozversion platform_buildid: 20170522033059 21:13:27 INFO - mozversion platform_changeset: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 21:13:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:13:27 INFO - mozversion platform_version: 55.0a1 21:13:27 INFO - using testdate: 1495426407 21:13:27 INFO - actual date: 1495426407 21:13:27 INFO - starting webserver on 'localhost:51139' 21:13:27 INFO - SUITE-START | Running 2 tests 21:13:27 INFO - TEST-START | dromaeo_css 21:13:27 INFO - operating with platform_type : linux_ 21:13:27 INFO - Initialising browser for dromaeo_css test... 21:13:27 INFO - TEST-INFO | started process 9983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHFw8Na/profile http://localhost:51139/getInfo.html) 21:13:27 INFO - PID 9983 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:13:31 INFO - PID 9983 | __metrics Screen width/height:1600/1200 21:13:31 INFO - PID 9983 | colorDepth:24 21:13:31 INFO - PID 9983 | Browser inner width/height: 1024/695 21:13:31 INFO - PID 9983 | __metrics 21:13:33 INFO - TEST-INFO | 9983: exit 0 21:13:33 INFO - Browser initialized. 21:13:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:13:33 INFO - TEST-INFO | started process 10163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHFw8Na/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:13:45 INFO - PID 10163 | RSS: Main: 169754624 21:13:45 INFO - PID 10163 | 21:16:50 INFO - PID 10163 | Cycle 1(1): loaded http://localhost:51139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51139/tests/dromaeo/cssquery-ext.html) 21:16:52 INFO - PID 10163 | RSS: Main: 174944256 21:16:52 INFO - PID 10163 | 21:19:54 INFO - PID 10163 | Cycle 1(1): loaded http://localhost:51139/tests/dromaeo/cssquery-ext.html (next: http://localhost:51139/tests/dromaeo/cssquery-jquery.html) 21:19:55 INFO - PID 10163 | RSS: Main: 173051904 21:19:55 INFO - PID 10163 | 21:22:57 INFO - PID 10163 | Cycle 1(1): loaded http://localhost:51139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51139/tests/dromaeo/cssquery-mootools.html) 21:22:57 INFO - PID 10163 | RSS: Main: 174669824 21:22:57 INFO - PID 10163 | 21:25:59 INFO - PID 10163 | Cycle 1(1): loaded http://localhost:51139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51139/tests/dromaeo/cssquery-prototype.html) 21:26:00 INFO - PID 10163 | RSS: Main: 172412928 21:26:00 INFO - PID 10163 | 21:29:03 INFO - PID 10163 | Cycle 1(1): loaded http://localhost:51139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51139/tests/dromaeo/cssquery-yui.html) 21:29:03 INFO - PID 10163 | RSS: Main: 172130304 21:29:03 INFO - PID 10163 | 21:32:05 INFO - PID 10163 | Cycle 1(1): loaded http://localhost:51139/tests/dromaeo/cssquery-yui.html (next: http://localhost:51139/tests/dromaeo/cssquery-dojo.html) 21:32:06 INFO - PID 10163 | RSS: Main: 179826688 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | __start_tp_report 21:32:06 INFO - PID 10163 | _x_x_mozilla_page_load 21:32:06 INFO - PID 10163 | _x_x_mozilla_page_load_details 21:32:06 INFO - PID 10163 | |i|pagename|runs| 21:32:06 INFO - PID 10163 | |0;dojo.html;2736.8084234103612;2743.6433263675717;2779.7359250871173;2785.4289870576536;2790.414013057259;5231;5395.946040539593;5396.892062158764;5406.756695948687;5434.15770555564;5305.946940530594;5368.865778355534;5420.24116623672;5427.674339539631;5436.673799572029;4708.340832283483;4729.148753224418;4733.857984260478;4800.711957282557;4819.2530157825595;4762.166620841356;4799.3520874682;4865.902681946359;4895.55939965403;4928.137575924199;4642.025174713314;4806;4806.663533552653;4823.445303790057;4853.4418541867435;4728.078024785168;4750.714957102585;4762.714237145748;4773.904521909577;4780.880477988043;4681.859544213679;4729.905401891977;4762.28565715142;4777.402824646919;4818.4217893852965;5387.922415516912;5388.811391601275;5390.487903649187;5394.271773310631;5399.83800485986;5680.4319568043275;5744.195812586241;5757.712114394305;5826.679532625704;5845.152452894349;5875.8531036724;5881.500072493843;5887.175795388649;5892.970535147339;5918.260217472816;5399.83800485986;5421.891562168735;5424.159255315432;5433.701146436944;5434.2935418395355;5900.704964751745;5983.102534619842;5986.191864098291;5990.161377407167;6014.609050411709;5672.971635141798;5689.345725241567;5715.657060576379;5720.056190728483;5721.199032135504;5778.6821724804695;5784.623999440023;5808.07070868659;5816.88366232673;5817;5615.0454422748235;5702.087665973424;5703.7148142592705;5707.514861236841;5725.398833122462;5696.3733989261145;5706.115552089433;5708.885822283531;5709.857253568694;5718.885622287614;4683.648726345537;4759.524047595212;4781.784819683123;4827.106985207748;4853.19922212838;4125.381192821101;4138.958610413918;4145.274576949022;4173.770442625685;4189.224993376235;4807.302941073524;4895;4899.559039686445;4901.43633482147;4946.08497427977;5653.547716182696;5721.942780572224;5788.681622510718;5820.330661973927;5841.88316233673;4831.0820944020525;4890.168671325812;4919.532644398776;4924.212126059813;4933.45731969483;5158.252053452228;5174.689518628894;5181.896362072813;5185.974070129625;5220.608454365938;5283.128283833278;5357.732113394237;5378.139497680352;5405.270288511001;5448.264484294569;5781.566382521243;5786.6528008317955;5786.884262314646;5788.739506722123;5790.739416726173;5233.267342571967;5287.365516138088;5324.9733751331;5340.412554618911;5392.406835248198;5718.828435146952;5760.423957604374;5806.5645076618575;5823.621464604787;5827.213326200908;5726.79956201531;5870.55970802183;5875.794347197828;5882.49998750111;5884.941150588439;5535.114381698909;5624.268845050117;5628.74670639814;5634.126710359901;5674.574406919415;5632;5647.124695672177;5647.491725744702;5655.208270842168;5686.573506987075;5557.805476808292;5577.358603760619;5583;5595.524380427709;5599.720013999366;5569.944300556943;5639.887202256014;5668.943310567007;5677.063284558001;5724.771009159587;5418.729063546885;5425.511703946664;5426.240326354393;5445.237666726583;5540.944590554042 21:32:06 INFO - PID 10163 | |1;ext.html;582.7843697831803;637.9425851673349;658.1969996604145;1186.2467333243394;1190.3393616542826;34588.4811727824;35003.299934001305;35280.70675406097;35413.46879796805;35450;33426.33147337052;34203.82898085512;34222.31555368891;34229.48655770165;34282.14294642635;6887.586744795316;7046.929530704704;7050.189228238742;7052.025432878777;7053.224145344008;6820.147481564804;6872.587644741331;6925.030495730602;6930.72277108915;6952.617606031667;6863.382295593396;6931.653417329138;6947.235804061549;6961.408280296181;6964.860702785942;6868.896966545506;6889.689963951634;6920.653967301665;6956.965215173942;6967.512274140812;6821.965890170517;6892.483063770237;6908.274631163756;6909.412699920513;6919.204291506491;32047.359052818814;32220.516692249636;32244;32278.515822262685;32362.352752945044;3066.1874603230162;3094.9690503094907;3096.5974423324824;3105.1460848266684;3108.036508682316;24443.26670199879;24515;24527.141550045664;24555.38611534708;24591;2984.4627966965936;3015.517517197238;3034.544818277254;3038.969610303891;3041.148478426022;144080;144151;144324;151887;154441;39346.40980385296;39691;39781.40327895084;39947.2010559793;39963.40054899179;42108.15783684309;42122.15755684869;45071.77464112724;45446.63660090203;45461.318080228826;10986.890131098746;11132.777344453227;11134.3876086816;11149.498272577754;11153;8690.04409514953;8710.259627931697;8718.86921696175;8735.301175905912;8740.21338079576;12951.546695865787;12972.740545189232;12999.67079338789;13069.085164038426;13158.802617960739;5366.436524164907;5370.409254981949;5460.945390546044;5573.359063707644;5577.9163312550345;796.7610365880995;815.8980127484065;848.4061157189992;849.1720572441819;855.922966932979;19096.361455417944;19366.800769634312;20002.199912003358;20051.097700603506;20406.69389959152;925.9906003971398;948.5399581203111;974.5078735238659;975.2100798353357;980.8626792249091;10848.620298289521;11052.226344155994;11290.830637540443;11307;11453.942730286462;174956;175757;175762;175874;176936;40935;41275.793621031706;41368.37947430791;41399.1720165595;41455.79272103681;1180.959392706318;1220.4507971413077;1226.9877301226873;1237.9876201238053;1249.900007999358;19338.226470941005;19947.401577952685;20620.484487887923;20644.896775516027;20821.791782081986;29577.85211074017;29587.408251835273;29628.407431851672;29780.553291701075;29830;156241;157233;158144;158372;158521;28678.13965581036;28844.855775720986;29072.273193169494;29092.854535727187;29140;34515.654843451244;34538.30923381468;34856.47715284222;35516.644833551334;35919.64080359163;25308.62037069482;26237.606435903093;26932;27049.323766905985;27505.449891002467;26296;26943.776022685324;26951.595726064515;27844.44311113807;28273.293167670974;30442.39115217639;30518.237044074074;30519;30562.388752225277;30591.388172236875;25184.49631007406;26091.60862587025;26453.206403807915;26745.86627066852;26959;20040.298589549297;21801.781982180608;21968.681879087308;22246.555068898208;22269.220577279717 21:32:06 INFO - PID 10163 | |2;jquery.html;397.1183971583088;400.6714494114827;402.9073313137979;403.92325458162946;429.4974879391112;14418.134911905294;15246.00900941438;17178.570535736613;18000.72998905016;18046;17129.657406851857;17414.129293535338;17867.463976080737;19118.13968371423;19424.805751942476;5271.973640131794;5332.760025798839;5392.272043274166;5549.0289199390145;5555.472230138151;5245.318108645871;5292.497212764782;5313.203019547061;5335.466453354672;5340.332458442695;5214.739263036833;5444.700541470217;5455.727213639322;5468.234447177399;5488.506034456898;5353.919691204615;5365.275687782138;5374.973125134369;5406.405295417501;5432.864178395532;4765.714057156547;4835.419749630032;4866.075445665312;4866.878328041792;4872.951270487285;21952.780472195394;22079;22124.668129978065;22690.773092269195;22884.084636614516;1629.551873234858;1678;1679.6388776413007;1679.7984241891052;1688.5272123805355;14496.710065798625;14541.34563944625;14952.551423457206;15210.923945380202;15254.847451525453;2003.4190084875368;2050.3746357361;2067.359118673216;2129.4144110369616;2131.4032071020138;83181.42502162379;85064.57467712683;87307.56346218228;87376.25247495015;89661.10338896593;10431.321964072311;10845.891541084646;10848.240623156304;10899.1280697544;11050.171237157245;14887;14922.418619531234;14946.32741526634;14955.925220374045;14966.17686027279;7156.069710937545;7180.210176880539;7380.261973802684;7451.701931922662;7480.251974802585;6566.080748695186;6605.768798092044;6643.136392269071;6834.965825170842;6835.624040677711;6891.277180704824;6910.516263861481;6986.685599148051;7107.573545587281;7119.288071192839;1896;1906.752122224102;1908.8759230649964;1913.7033759767257;1986.5430950881089;829.9875501867476;853.0744142605342;865.2040123086775;886.0342226972631;892.0945240580816;17080.658386832194;17279.91360043192;17419.47741567755;17712.822871771376;18004.459866204033;853.3727710133047;859.8495263328892;870.5766072471428;873;890.7283278599959;9366.29752768545;9566.13904748576;9717.17404020666;9788.412695238309;9862.50687465624;308392;308530;310095;312204;314349;72328.27671723215;72578;72715.63642181756;74186.62906685432;74416.62791686007;1006.8453509489698;1028.89711028898;1031.046282188972;1049.2812423489934;1099.725068732817;16144.838551614333;18800.62398752045;18935.621287574446;18992.145353459404;19195.712064319327;40039.79980100081;40656.39015414831;41026;41362.79318603388;42316.36525452059;51526.48473515217;51981.22028169656;52976.73511632417;54355.72822135864;55115.1106111736;12105.455254513745;12444.937775311066;12457.252564846138;12488.562900298446;12513.311767852856;13572.524961626295;13641.658958526115;13702.52041178554;13799.2410417428;13896.51362202318;11487.483063262007;11528.59649912249;11708.765824683629;11814.468348924147;12068.39658017078;10337.17302615804;10432.791344173225;10433.26967112295;10483.108935740242;10538.57845686164;11663.066954643778;11818;11851.170418070653;12349.073819463756;12391.93804030974;12264.38678066111;12292.446839892047;12453.879150876464;12544.686382840502;12763.872361276268;11206.38364889939;11536.36549989725;11679.299242045505;11755;12092.455839487067 21:32:06 INFO - PID 10163 | |3;mootools.html;1208.25088445164;1272.7645385603664;1282.8845403913647;1283.6854970532222;1286.4018231522346;9718.757031074218;9882.604695812177;10061.446620435881;10104.393736375823;10171.84742228867;9880.703578892644;10086.798264034715;10100;10167.847482287772;10189.643362482297;2211.3144925073198;2245.7305123385217;2251.549690061986;2252.6170551006285;2263.54729054189;2124.1184908263053;2187.628103222448;2189.080586153811;2192.5286063496346;2193.0679461228992;2162.4701948022757;2163.8593491423085;2198.2635817001324;2201.218567408571;2210.071769856656;2059.8970051497367;2079.365793433002;2096.6854971754206;2097.569998150383;2108.0303060592146;2057.351934140741;2088.95822083559;2138.7540432850265;2173.0873033326043;2193.8793366364844;9880.90119098807;9883.357581757164;9896.653617123366;9947.25395595326;9961.750956226153;5298.788048478056;5463.808766693147;5467.753951072172;5468.507834294933;5468.945310546884;2985.9701402986125;3188.9362212755614;3256.1208473711963;3259.788113772597;3270.6565810590023;993.0764389118117;1027.5016616940777;1041.0838462153256;1050.4747626186906;1050.5745173204864;13895.235762033084;14143.787843182257;14146.36341364641;14154.575362739031;14176.716465670732;4523.11799199153;4561.657875659273;4719.244920812654;4817.301491283814;4830.734309613005;10170.745731356626;10223.386596804066;10226;10267.897321026843;10311.587536498457;5384.596155288369;5398.64908780928;5411.702356370359;5427.674339539641;5435.402105768362;4891.413030436371;5038.974805126024;5043.142665746832;5059.62052846038;5064.569511591482;3560.964390356063;3588.372034893883;3623.1304486923477;3646.8176591170336;3724.2179142380405;1073.6617965340893;1075.2688172042929;1080.5461706083306;1095.4194277033184;1107.8836722144058;718.8849784034529;738.7155944961229;741.855338209044;743.8177646476648;755.2296657409412;5379.704116273564;5449.945500544944;5500.339959204841;5572.3870374258795;5588.245586845724;512.9974350128225;551.7599844067844;554.7864072332101;555.5666580067553;565.0366125755659;3285.704286614216;3844.1350696093155;3976.8608098716404;3992.680585553149;3998.3202855514633;11511.30932144074;12316.938415307866;12684.492620295085;12698.80951785724;12702.745945081047;12093.093018023683;12098.153129281041;12385.814212786816;12537.623871283877;12605.495780168874;7007.789766306917;7127.786166415016;7128.394086502705;7143.392811611071;7155.248698886646;5793.797217097382;5833.387494313206;5893.970530147493;5906.232189815297;6008.399160083956;11047.447627618747;11198.38408887519;11217.102631789274;11378.658640240476;11522;11548.538058477567;11563.248388855034;11611;11626;11737.237079589799;7818.765437036898;8021.799455013671;8066.637001335072;8160.26557609818;8172.101068882299;9125.863112053192;9298.302627303116;9319.254459643347;9320.440773553608;9322.394044387092;7920.287174154354;7924.28681418652;8133.2680058794995;8234.711785087493;8308.70919517814;7556.395488361028;7898.328642065489;7959;7960.562169080525;8191.467554608931;7065.505414621133;7300.963495182703;7343.155537113087;7350.411967042731;7360.705571777069;4797.280407938837;5346.625736198429;5394.865128371822;5573.1918871762555;5694.487496125369;5118.181091025418;5132.230165475208;5153.123968925367;5159.251908473326;5369.785208591768 21:32:06 INFO - PID 10163 | |4;prototype.html;357.6459305287766;367.3772954841544;372.92355067211224;378.292592851368;382.79520456555747;5408;5548.278723765905;5609.775608975641;5630.77476900924;5644.447776861365;5338.332708411449;5420.756065977031;5435.130379139338;5453.563714902808;5465.606270401042;4106.876793696194;4107.075907920709;4111.588841115894;4114.6296833285;4116.176764647068;4118.238125946709;4132.421460995463;4132.574261879662;4182.560831112735;4309.418228539154;4304.859212308741;4330.84842030529;4333.761643109628;4335.479742430897;4341.39220509129;4337.587929146726;4338.84814031509;4358.215521206197;4361.978190109061;4378.058717375748;3843.7693738375506;3920.705947053954;3958.346872766019;3978.2839088963974;3979.900502487461;5406.54044406226;5416.891662166774;5420.235679803329;5424.674519528841;5454.10007348787;5120.743962801882;5146.176611742103;5156.458571849939;5162.883217880689;5165.22521621756;5838.065909454467;5842.853928651775;5843.211166492511;5866.354700982888;5905.055191169392;4387.815289871749;4401.22978478765;4426.207386008672;4427.535108813592;4438.800253988546;5964.1650168976375;6142.692865356715;6196.163517925068;6218.28489723683;6247.781327653511;4277.636400905958;4279.636230920344;4295.6778241632;4299.9570004300185;4299.9570004300185;4333.371661109121;4342.435483387139;4346.543612920661;4363.4109395231235;4385.693001489865;4951.579115775199;4957.975210123998;4971.975140124277;5102.821401250939;5138.332016837787;5877.118432235199;5889.322727886262;5898.1715668143015;5900.822975310662;5901.40985901415;1594.9122798246208;1612.9919350403172;1619.6031972166895;1627.1620115640455;1628.210317995771;1125.6960620632547;1158.1892675127276;1160.976780464386;1163.3252713426193;1166.6208482243305;5029.949700502948;5030.144875371196;5036.622253331015;5040.7731652075745;5049.166887463527;6037.335893051761;6066.939330606726;6083.482903953125;6090.573659843857;6103.877922441527;4812.663113582085;4984.950150498521;5019.121653710586;5062.696238225718;5086.54221120101;3170.889018884328;3190.6171259449015;3207.615086189672;3222.113918672337;3224.339010502841;5471.316085489314;5592.105263157957;5596.636218645775;5630.23991761107;5659.575531835047;6185.165002724664;6213.161223234896;6225.470834978987;6233.563650544509;6243.594166379171;5557.194206840067;5613.607047506635;5617.691026993554;5639.915401268984;5650.576206784425;5991.700414979146;5999.640021598718;6051;6051.092336149437;6060.030395136757;5825.271841019872;5871.559633027455;5943.851403714942;5945.40545945402;5955.612885162624;5607.2149899014985;5638.464345887134;5667.914981275367;5686.857828554319;5687.744051517609;4064.1871625675576;4079.7960101995377;4090.1798699578403;4097.549269580403;4098.6516146127915;5994.970025149846;6063.878722425438;6116.969415152896;6157.4458298753325;6163.784267550794;5896.64620122794;5897.557683173865;5906.438888305604;5910.586258961831;5918.964181268175;5743.253377060955;5821.679807610622;5866.970665146647;5893.44012318829;5914.112883067574;5705.771769129188;5770.682612456355;5777.2200752897825;5789.652620842763;5840;5902.38025007368;5902.61632993854;5912.645241285537;5920.993431116634;5931;5600.383957764561;5675.205471233948;5705.828825135252;5711.143328500592;5718.828435146952 21:32:06 INFO - PID 10163 | |5;yui.html;716.7455553278583;734.9816254593635;749.7038669725458;760.2815339504167;761.330029573975;12230.571929982452;12799.680007999781;13199.604011879635;13943.721125577482;13971.022028458012;15104.244787760623;15520.922395388036;15665.608359791011;15677.84322156778;15704.764428533581;909.7452713240286;918.912703293186;921.1801496667971;922.4511415707643;923.2291036984126;898.6046139698511;901.2159421303476;901.378049146087;902.9503377314245;904.751193421811;963.4075043848018;969.4522594733988;969.5346233807777;970.7039352997333;973.7711637765119;957.1624828275259;960.1454705312277;961.3703024518917;962.9229661627053;963.59047404853;709.5139829216952;710.1513691139091;711.4130842055325;712.0600806934848;712.8039789057999;13956.371963261678;14370.568882933425;14430;14572.854271457256;14609.123452592772;15057.54827355181;15490.148041857694;15612.843871561367;15800.36798528069;16163.111028893407;11457.083433325313;11570.247933884271;11721.94139029308;11797.29216247028;11917.344546049964;2980.3145276586506;2984.3136078701805;2993.5659329397117;3002.6697063323236;3011.1719277198727;71776;71920.99999999948;72736.27263727348;73614.63192684056;75144.24855751482;12485.063620228337;12638.684032899067;12657.620271391874;12674.176178548365;12687.429065692066;21553;22630.547389052455;22643.20748773785;22647.547049058925;22852.65721014186;5868.882622347529;6065.6663883486835;6093.512518998469;6097.024476083805;6115.1744514490865;2759.613654088429;2798.664160300777;2804.6774620918445;2809.283632673655;2812.578113282983;3607.639236076424;3688.704903607705;3691.557013158438;3862.9806850965565;3972.741771784825;740.1857956248192;759.4835511851994;765.9042619672541;769.7767647382309;774.4656187230793;575.6517307029271;579.4147910610313;589.7699897040158;602.1599868183858;608.2184393054991;9124.95437522808;9567.234621230285;9835;9997.200223982063;10544.367337959748;562.3139769481227;572.5190839694676;573.5554944917723;579.0532479396218;583.8015074874563;4353.695241333076;4542.091581683677;4572.428446444194;4583.770811459413;4715.669903106749;51248.74375628098;52645.473545264824;54202;55169;56565;48926.510734892196;49201.753991229816;49336.25995610069;49472.01055978932;49777.50222497801;44257.557424425344;46716;46797.06405871932;47608.76195619;48049;9879.753006174904;10514.57941682324;10633.308834925705;10842.566297348018;11024.779504410028;24336;24625.29121796637;24667.50664986726;25225.11712090068;25696.100636477633;40563.39154912738;41955.7902210487;42528.787356063025;42964.35553466638;43999.340009899235;14274.357653905807;14474.34865431037;14612.123272603678;14720.631984200052;14939.925300373428;13566.59300220995;13844.792328114885;15428.30572624212;15453.768193477332;15835.049897006216;14308.141511509342;14557.34491947886;14646.26768661584;14710.485133020293;14911.850881491046;13060.346982651019;13666.52167174144;13708.725825483236;14069.226192559507;14329.283535822959;13766.31168441594;14364.425422982964;14583.125012499284;14709.117452952856;14864.331105100513;10601.25791194609;10949.83575246356;11015.944920275348;11096.33421994683;11175.49710263024;10911.618093366695;10949.288296260718;11085.889141108486;11331.263467874562;11352.091832653534 21:32:06 INFO - PID 10163 | __end_tp_report 21:32:06 INFO - PID 10163 | __start_cc_report 21:32:06 INFO - PID 10163 | _x_x_mozilla_cycle_collect,292 21:32:06 INFO - PID 10163 | __end_cc_report 21:32:06 INFO - PID 10163 | __startTimestamp1495427526087__endTimestamp 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | ------- Summary: start ------- 21:32:06 INFO - PID 10163 | Number of tests: 6 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | [#0] dojo.html Cycles:165 Average:5289.28 Median:5427.67 stddev:629.48 (11.6%) stddev-sans-first:598.71 21:32:06 INFO - PID 10163 | Values: 2736.8 2743.6 2779.7 2785.4 2790.4 5231.0 5395.9 5396.9 5406.8 5434.2 5305.9 5368.9 5420.2 5427.7 5436.7 4708.3 4729.1 4733.9 4800.7 4819.3 4762.2 4799.4 4865.9 4895.6 4928.1 4642.0 4806.0 4806.7 4823.4 4853.4 4728.1 4750.7 4762.7 4773.9 4780.9 4681.9 4729.9 4762.3 4777.4 4818.4 5387.9 5388.8 5390.5 5394.3 5399.8 5680.4 5744.2 5757.7 5826.7 5845.2 5875.9 5881.5 5887.2 5893.0 5918.3 5399.8 5421.9 5424.2 5433.7 5434.3 5900.7 5983.1 5986.2 5990.2 6014.6 5673.0 5689.3 5715.7 5720.1 5721.2 5778.7 5784.6 5808.1 5816.9 5817.0 5615.0 5702.1 5703.7 5707.5 5725.4 5696.4 5706.1 5708.9 5709.9 5718.9 4683.6 4759.5 4781.8 4827.1 4853.2 4125.4 4139.0 4145.3 4173.8 4189.2 4807.3 4895.0 4899.6 4901.4 4946.1 5653.5 5721.9 5788.7 5820.3 5841.9 4831.1 4890.2 4919.5 4924.2 4933.5 5158.3 5174.7 5181.9 5186.0 5220.6 5283.1 5357.7 5378.1 5405.3 5448.3 5781.6 5786.7 5786.9 5788.7 5790.7 5233.3 5287.4 5325.0 5340.4 5392.4 5718.8 5760.4 5806.6 5823.6 5827.2 5726.8 5870.6 5875.8 5882.5 5884.9 5535.1 5624.3 5628.7 5634.1 5674.6 5632.0 5647.1 5647.5 5655.2 5686.6 5557.8 5577.4 5583.0 5595.5 5599.7 5569.9 5639.9 5668.9 5677.1 5724.8 5418.7 5425.5 5426.2 5445.2 5540.9 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | [#1] ext.html Cycles:180 Average:30352.20 Median:30576.89 stddev:41561.41 (135.9%) stddev-sans-first:41617.89 21:32:06 INFO - PID 10163 | Values: 582.8 637.9 658.2 1186.2 1190.3 34588.5 35003.3 35280.7 35413.5 35450.0 33426.3 34203.8 34222.3 34229.5 34282.1 6887.6 7046.9 7050.2 7052.0 7053.2 6820.1 6872.6 6925.0 6930.7 6952.6 6863.4 6931.7 6947.2 6961.4 6964.9 6868.9 6889.7 6920.7 6957.0 6967.5 6822.0 6892.5 6908.3 6909.4 6919.2 32047.4 32220.5 32244.0 32278.5 32362.4 3066.2 3095.0 3096.6 3105.1 3108.0 24443.3 24515.0 24527.1 24555.4 24591.0 2984.5 3015.5 3034.5 3039.0 3041.1 144080.0 144151.0 144324.0 151887.0 154441.0 39346.4 39691.0 39781.4 39947.2 39963.4 42108.2 42122.2 45071.8 45446.6 45461.3 10986.9 11132.8 11134.4 11149.5 11153.0 8690.0 8710.3 8718.9 8735.3 8740.2 12951.5 12972.7 12999.7 13069.1 13158.8 5366.4 5370.4 5460.9 5573.4 5577.9 796.8 815.9 848.4 849.2 855.9 19096.4 19366.8 20002.2 20051.1 20406.7 926.0 948.5 974.5 975.2 980.9 10848.6 11052.2 11290.8 11307.0 11453.9 174956.0 175757.0 175762.0 175874.0 176936.0 40935.0 41275.8 41368.4 41399.2 41455.8 1181.0 1220.5 1227.0 1238.0 1249.9 19338.2 19947.4 20620.5 20644.9 20821.8 29577.9 29587.4 29628.4 29780.6 29830.0 156241.0 157233.0 158144.0 158372.0 158521.0 28678.1 28844.9 29072.3 29092.9 29140.0 34515.7 34538.3 34856.5 35516.6 35919.6 25308.6 26237.6 26932.0 27049.3 27505.4 26296.0 26943.8 26951.6 27844.4 28273.3 30442.4 30518.2 30519.0 30562.4 30591.4 25184.5 26091.6 26453.2 26745.9 26959.0 20040.3 21801.8 21968.7 22246.6 22269.2 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | [#2] jquery.html Cycles:180 Average:23576.52 Median:22015.89 stddev:52226.44 (237.2%) stddev-sans-first:52343.95 21:32:06 INFO - PID 10163 | Values: 397.1 400.7 402.9 403.9 429.5 14418.1 15246.0 17178.6 18000.7 18046.0 17129.7 17414.1 17867.5 19118.1 19424.8 5272.0 5332.8 5392.3 5549.0 5555.5 5245.3 5292.5 5313.2 5335.5 5340.3 5214.7 5444.7 5455.7 5468.2 5488.5 5353.9 5365.3 5375.0 5406.4 5432.9 4765.7 4835.4 4866.1 4866.9 4873.0 21952.8 22079.0 22124.7 22690.8 22884.1 1629.6 1678.0 1679.6 1679.8 1688.5 14496.7 14541.3 14952.6 15210.9 15254.8 2003.4 2050.4 2067.4 2129.4 2131.4 83181.4 85064.6 87307.6 87376.3 89661.1 10431.3 10845.9 10848.2 10899.1 11050.2 14887.0 14922.4 14946.3 14955.9 14966.2 7156.1 7180.2 7380.3 7451.7 7480.3 6566.1 6605.8 6643.1 6835.0 6835.6 6891.3 6910.5 6986.7 7107.6 7119.3 1896.0 1906.8 1908.9 1913.7 1986.5 830.0 853.1 865.2 886.0 892.1 17080.7 17279.9 17419.5 17712.8 18004.5 853.4 859.8 870.6 873.0 890.7 9366.3 9566.1 9717.2 9788.4 9862.5 308392.0 308530.0 310095.0 312204.0 314349.0 72328.3 72578.0 72715.6 74186.6 74416.6 1006.8 1028.9 1031.0 1049.3 1099.7 16144.8 18800.6 18935.6 18992.1 19195.7 40039.8 40656.4 41026.0 41362.8 42316.4 51526.5 51981.2 52976.7 54355.7 55115.1 12105.5 12444.9 12457.3 12488.6 12513.3 13572.5 13641.7 13702.5 13799.2 13896.5 11487.5 11528.6 11708.8 11814.5 12068.4 10337.2 10432.8 10433.3 10483.1 10538.6 11663.1 11818.0 11851.2 12349.1 12391.9 12264.4 12292.4 12453.9 12544.7 12763.9 11206.4 11536.4 11679.3 11755.0 12092.5 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | [#3] mootools.html Cycles:180 Average:6064.35 Median:4260.72 stddev:3823.68 (89.7%) stddev-sans-first:3816.99 21:32:06 INFO - PID 10163 | Values: 1208.3 1272.8 1282.9 1283.7 1286.4 9718.8 9882.6 10061.4 10104.4 10171.8 9880.7 10086.8 10100.0 10167.8 10189.6 2211.3 2245.7 2251.5 2252.6 2263.5 2124.1 2187.6 2189.1 2192.5 2193.1 2162.5 2163.9 2198.3 2201.2 2210.1 2059.9 2079.4 2096.7 2097.6 2108.0 2057.4 2089.0 2138.8 2173.1 2193.9 9880.9 9883.4 9896.7 9947.3 9961.8 5298.8 5463.8 5467.8 5468.5 5468.9 2986.0 3188.9 3256.1 3259.8 3270.7 993.1 1027.5 1041.1 1050.5 1050.6 13895.2 14143.8 14146.4 14154.6 14176.7 4523.1 4561.7 4719.2 4817.3 4830.7 10170.7 10223.4 10226.0 10267.9 10311.6 5384.6 5398.6 5411.7 5427.7 5435.4 4891.4 5039.0 5043.1 5059.6 5064.6 3561.0 3588.4 3623.1 3646.8 3724.2 1073.7 1075.3 1080.5 1095.4 1107.9 718.9 738.7 741.9 743.8 755.2 5379.7 5449.9 5500.3 5572.4 5588.2 513.0 551.8 554.8 555.6 565.0 3285.7 3844.1 3976.9 3992.7 3998.3 11511.3 12316.9 12684.5 12698.8 12702.7 12093.1 12098.2 12385.8 12537.6 12605.5 7007.8 7127.8 7128.4 7143.4 7155.2 5793.8 5833.4 5894.0 5906.2 6008.4 11047.4 11198.4 11217.1 11378.7 11522.0 11548.5 11563.2 11611.0 11626.0 11737.2 7818.8 8021.8 8066.6 8160.3 8172.1 9125.9 9298.3 9319.3 9320.4 9322.4 7920.3 7924.3 8133.3 8234.7 8308.7 7556.4 7898.3 7959.0 7960.6 8191.5 7065.5 7301.0 7343.2 7350.4 7360.7 4797.3 5346.6 5394.9 5573.2 5694.5 5118.2 5132.2 5153.1 5159.3 5369.8 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | [#4] prototype.html Cycles:180 Average:4868.13 Median:5422.72 stddev:1396.41 (25.8%) stddev-sans-first:1358.67 21:32:06 INFO - PID 10163 | Values: 357.6 367.4 372.9 378.3 382.8 5408.0 5548.3 5609.8 5630.8 5644.4 5338.3 5420.8 5435.1 5453.6 5465.6 4106.9 4107.1 4111.6 4114.6 4116.2 4118.2 4132.4 4132.6 4182.6 4309.4 4304.9 4330.8 4333.8 4335.5 4341.4 4337.6 4338.8 4358.2 4362.0 4378.1 3843.8 3920.7 3958.3 3978.3 3979.9 5406.5 5416.9 5420.2 5424.7 5454.1 5120.7 5146.2 5156.5 5162.9 5165.2 5838.1 5842.9 5843.2 5866.4 5905.1 4387.8 4401.2 4426.2 4427.5 4438.8 5964.2 6142.7 6196.2 6218.3 6247.8 4277.6 4279.6 4295.7 4300.0 4300.0 4333.4 4342.4 4346.5 4363.4 4385.7 4951.6 4958.0 4972.0 5102.8 5138.3 5877.1 5889.3 5898.2 5900.8 5901.4 1594.9 1613.0 1619.6 1627.2 1628.2 1125.7 1158.2 1161.0 1163.3 1166.6 5029.9 5030.1 5036.6 5040.8 5049.2 6037.3 6066.9 6083.5 6090.6 6103.9 4812.7 4985.0 5019.1 5062.7 5086.5 3170.9 3190.6 3207.6 3222.1 3224.3 5471.3 5592.1 5596.6 5630.2 5659.6 6185.2 6213.2 6225.5 6233.6 6243.6 5557.2 5613.6 5617.7 5639.9 5650.6 5991.7 5999.6 6051.0 6051.1 6060.0 5825.3 5871.6 5943.9 5945.4 5955.6 5607.2 5638.5 5667.9 5686.9 5687.7 4064.2 4079.8 4090.2 4097.5 4098.7 5995.0 6063.9 6117.0 6157.4 6163.8 5896.6 5897.6 5906.4 5910.6 5919.0 5743.3 5821.7 5867.0 5893.4 5914.1 5705.8 5770.7 5777.2 5789.7 5840.0 5902.4 5902.6 5912.6 5921.0 5931.0 5600.4 5675.2 5705.8 5711.1 5718.8 21:32:06 INFO - PID 10163 | 21:32:06 INFO - PID 10163 | [#5] yui.html Cycles:180 Average:14943.55 Median:3648.17 stddev:17135.63 (469.7%) stddev-sans-first:17150.39 21:32:06 INFO - PID 10163 | Values: 716.7 735.0 749.7 760.3 761.3 12230.6 12799.7 13199.6 13943.7 13971.0 15104.2 15520.9 15665.6 15677.8 15704.8 909.7 918.9 921.2 922.5 923.2 898.6 901.2 901.4 903.0 904.8 963.4 969.5 969.5 970.7 973.8 957.2 960.1 961.4 962.9 963.6 709.5 710.2 711.4 712.1 712.8 13956.4 14370.6 14430.0 14572.9 14609.1 15057.5 15490.1 15612.8 15800.4 16163.1 11457.1 11570.2 11721.9 11797.3 11917.3 2980.3 2984.3 2993.6 3002.7 3011.2 71776.0 71921.0 72736.3 73614.6 75144.2 12485.1 12638.7 12657.6 12674.2 12687.4 21553.0 22630.5 22643.2 22647.5 22852.7 5868.9 6065.7 6093.5 6097.0 6115.2 2759.6 2798.7 2804.7 2809.3 2812.6 3607.6 3688.7 3691.6 3863.0 3972.7 740.2 759.5 765.9 769.8 774.5 575.7 579.4 589.8 602.2 608.2 9125.0 9567.2 9835.0 9997.2 10544.4 562.3 572.5 573.6 579.1 583.8 4353.7 4542.1 4572.4 4583.8 4715.7 51248.7 52645.5 54202.0 55169.0 56565.0 48926.5 49201.8 49336.3 49472.0 49777.5 44257.6 46716.0 46797.1 47608.8 48049.0 9879.8 10514.6 10633.3 10842.6 11024.8 24336.0 24625.3 24667.5 25225.1 25696.1 40563.4 41955.8 42528.8 42964.4 43999.3 14274.4 14474.3 14612.1 14720.6 14939.9 13566.6 13844.8 15428.3 15453.8 15835.0 14308.1 14557.3 14646.3 14710.5 14911.9 13060.3 13666.5 13708.7 14069.2 14329.3 13766.3 14364.4 14583.1 14709.1 14864.3 10601.3 10949.8 11015.9 11096.3 11175.5 10911.6 10949.3 11085.9 11331.3 11352.1 21:32:06 INFO - PID 10163 | -------- Summary: end -------- 21:32:06 INFO - PID 10163 | 21:32:06 INFO - TEST-INFO | 10163: exit 0 21:32:06 INFO - TEST-OK | dromaeo_css | took 1119650ms 21:32:06 INFO - TEST-START | kraken 21:32:06 INFO - operating with platform_type : linux_ 21:32:06 INFO - Initialising browser for kraken test... 21:32:06 INFO - TEST-INFO | started process 10585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7pvYgt/profile http://localhost:51139/getInfo.html) 21:32:07 INFO - PID 10585 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:32:10 INFO - PID 10585 | __metrics Screen width/height:1600/1200 21:32:10 INFO - PID 10585 | colorDepth:24 21:32:10 INFO - PID 10585 | Browser inner width/height: 1024/695 21:32:10 INFO - PID 10585 | __metrics 21:32:12 INFO - TEST-INFO | 10585: exit 0 21:32:12 INFO - Browser initialized. 21:32:12 INFO - Running cycle 1/1 for kraken test... 21:32:12 INFO - TEST-INFO | started process 10763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7pvYgt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:32:24 INFO - PID 10763 | RSS: Main: 169938944 21:32:24 INFO - PID 10763 | 21:32:27 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51139/tests/kraken/driver.html?testName=audio-beat-detection) 21:32:28 INFO - PID 10763 | RSS: Main: 174370816 21:32:28 INFO - PID 10763 | 21:32:30 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51139/tests/kraken/driver.html?testName=audio-dft) 21:32:31 INFO - PID 10763 | RSS: Main: 173727744 21:32:31 INFO - PID 10763 | 21:32:34 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51139/tests/kraken/driver.html?testName=audio-fft) 21:32:35 INFO - PID 10763 | RSS: Main: 169324544 21:32:35 INFO - PID 10763 | 21:32:37 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51139/tests/kraken/driver.html?testName=audio-oscillator) 21:32:37 INFO - PID 10763 | RSS: Main: 169943040 21:32:37 INFO - PID 10763 | 21:32:39 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:32:40 INFO - PID 10763 | RSS: Main: 170106880 21:32:40 INFO - PID 10763 | 21:32:43 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51139/tests/kraken/driver.html?testName=imaging-darkroom) 21:32:44 INFO - PID 10763 | RSS: Main: 173948928 21:32:44 INFO - PID 10763 | 21:32:47 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51139/tests/kraken/driver.html?testName=imaging-desaturate) 21:32:48 INFO - PID 10763 | RSS: Main: 171941888 21:32:48 INFO - PID 10763 | 21:32:51 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51139/tests/kraken/driver.html?testName=json-parse-financial) 21:32:52 INFO - PID 10763 | RSS: Main: 172716032 21:32:52 INFO - PID 10763 | 21:32:53 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:32:54 INFO - PID 10763 | RSS: Main: 172982272 21:32:54 INFO - PID 10763 | 21:32:56 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:32:56 INFO - PID 10763 | RSS: Main: 172920832 21:32:56 INFO - PID 10763 | 21:32:58 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:32:59 INFO - PID 10763 | RSS: Main: 173232128 21:32:59 INFO - PID 10763 | 21:33:02 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:33:03 INFO - PID 10763 | RSS: Main: 173207552 21:33:03 INFO - PID 10763 | 21:33:06 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:33:06 INFO - PID 10763 | RSS: Main: 172830720 21:33:06 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | Cycle 1(1): loaded http://localhost:51139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51139/tests/kraken/driver.html?testName=ai-astar) 21:33:08 INFO - PID 10763 | RSS: Main: 174170112 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | __start_tp_report 21:33:08 INFO - PID 10763 | _x_x_mozilla_page_load 21:33:08 INFO - PID 10763 | _x_x_mozilla_page_load_details 21:33:08 INFO - PID 10763 | |i|pagename|runs| 21:33:08 INFO - PID 10763 | |0;ai-astar;105;113;113;112;111;112;114;113;111;116 21:33:08 INFO - PID 10763 | |1;audio-beat-detection;151;125;124;181;128;128;123;126;147;124 21:33:08 INFO - PID 10763 | |2;audio-dft;166;164;165;163;161;163;167;166;162;164 21:33:08 INFO - PID 10763 | |3;audio-fft;77;77;76;108;75;76;75;76;101;75 21:33:08 INFO - PID 10763 | |4;audio-oscillator;84;84;105;85;84;83;96;86;85;107 21:33:08 INFO - PID 10763 | |5;imaging-gaussian-blur;119;115;114;114;114;113;115;115;114;115 21:33:08 INFO - PID 10763 | |6;imaging-darkroom;153;155;152;150;151;155;153;153;150;150 21:33:08 INFO - PID 10763 | |7;imaging-desaturate;96;96;95;95;94;95;94;95;95;95 21:33:08 INFO - PID 10763 | |8;json-parse-financial;55;55;54;55;55;59;58;55;56;55 21:33:08 INFO - PID 10763 | |9;json-stringify-tinderbox;56;56;57;56;59;59;56;56;56;57 21:33:08 INFO - PID 10763 | |10;stanford-crypto-aes;87;82;82;94;81;83;83;84;82;92 21:33:08 INFO - PID 10763 | |11;stanford-crypto-ccm;140;139;141;141;134;150;136;130;184;137 21:33:08 INFO - PID 10763 | |12;stanford-crypto-pbkdf2;186;194;182;192;195;189;201;189;190;196 21:33:08 INFO - PID 10763 | |13;stanford-crypto-sha256-iterative;75;75;74;74;74;74;74;77;73;73 21:33:08 INFO - PID 10763 | __end_tp_report 21:33:08 INFO - PID 10763 | __start_cc_report 21:33:08 INFO - PID 10763 | _x_x_mozilla_cycle_collect,755 21:33:08 INFO - PID 10763 | __end_cc_report 21:33:08 INFO - PID 10763 | __startTimestamp1495427588987__endTimestamp 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | ------- Summary: start ------- 21:33:08 INFO - PID 10763 | Number of tests: 14 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.87 (2.5%) stddev-sans-first:1.56 21:33:08 INFO - PID 10763 | Values: 105.0 113.0 113.0 112.0 111.0 112.0 114.0 113.0 111.0 116.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:128.00 stddev:18.79 (14.7%) stddev-sans-first:19.09 21:33:08 INFO - PID 10763 | Values: 151.0 125.0 124.0 181.0 128.0 128.0 123.0 126.0 147.0 124.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:1.91 (1.2%) stddev-sans-first:1.90 21:33:08 INFO - PID 10763 | Values: 166.0 164.0 165.0 163.0 161.0 163.0 167.0 166.0 162.0 164.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:12.20 (16.1%) stddev-sans-first:12.83 21:33:08 INFO - PID 10763 | Values: 77.0 77.0 76.0 108.0 75.0 76.0 75.0 76.0 101.0 75.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.50 stddev:9.27 (11.0%) stddev-sans-first:9.58 21:33:08 INFO - PID 10763 | Values: 84.0 84.0 105.0 85.0 84.0 83.0 96.0 86.0 85.0 107.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.62 (1.4%) stddev-sans-first:0.71 21:33:08 INFO - PID 10763 | Values: 119.0 115.0 114.0 114.0 114.0 113.0 115.0 115.0 114.0 115.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:153.00 stddev:1.93 (1.3%) stddev-sans-first:2.03 21:33:08 INFO - PID 10763 | Values: 153.0 155.0 152.0 150.0 151.0 155.0 153.0 153.0 150.0 150.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 21:33:08 INFO - PID 10763 | Values: 96.0 96.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 21:33:08 INFO - PID 10763 | 21:33:08 INFO - PID 10763 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.00 stddev:1.57 (2.8%) stddev-sans-first:1.64 21:33:08 INFO - PID 10763 | Values: 55.0 55.0 54.0 55.0 55.0 59.0 58.0 55.0 56.0 55.0 21:33:08 INFO - PID 10763 | 21:33:09 INFO - PID 10763 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.50 stddev:1.23 (2.2%) stddev-sans-first:1.27 21:33:09 INFO - PID 10763 | Values: 56.0 56.0 57.0 56.0 59.0 59.0 56.0 56.0 56.0 57.0 21:33:09 INFO - PID 10763 | 21:33:09 INFO - PID 10763 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:83.50 stddev:4.55 (5.4%) stddev-sans-first:4.76 21:33:09 INFO - PID 10763 | Values: 87.0 82.0 82.0 94.0 81.0 83.0 83.0 84.0 82.0 92.0 21:33:09 INFO - PID 10763 | 21:33:09 INFO - PID 10763 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:140.50 stddev:15.27 (10.9%) stddev-sans-first:16.15 21:33:09 INFO - PID 10763 | Values: 140.0 139.0 141.0 141.0 134.0 150.0 136.0 130.0 184.0 137.0 21:33:09 INFO - PID 10763 | 21:33:09 INFO - PID 10763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:193.00 stddev:5.42 (2.8%) stddev-sans-first:5.39 21:33:09 INFO - PID 10763 | Values: 186.0 194.0 182.0 192.0 195.0 189.0 201.0 189.0 190.0 196.0 21:33:09 INFO - PID 10763 | 21:33:09 INFO - PID 10763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 21:33:09 INFO - PID 10763 | Values: 75.0 75.0 74.0 74.0 74.0 74.0 74.0 77.0 73.0 73.0 21:33:09 INFO - PID 10763 | -------- Summary: end -------- 21:33:09 INFO - PID 10763 | 21:33:10 INFO - TEST-INFO | 10763: exit 0 21:33:10 INFO - TEST-OK | kraken | took 63254ms 21:33:10 INFO - SUITE-END | took 1182s 21:33:10 INFO - Completed test suite (00:19:43) 21:33:10 INFO - javascript benchmark 21:33:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6740.250542002461, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2736.8084234103612, 2743.6433263675717, 2779.7359250871173, 2785.4289870576536, 2790.414013057259, 5231.0, 5395.946040539593, 5396.892062158764, 5406.756695948687, 5434.15770555564, 5305.946940530594, 5368.865778355534, 5420.24116623672, 5427.674339539631, 5436.673799572029, 4708.340832283483, 4729.148753224418, 4733.857984260478, 4800.711957282557, 4819.2530157825595, 4762.166620841356, 4799.3520874682, 4865.902681946359, 4895.55939965403, 4928.137575924199, 4642.025174713314, 4806.0, 4806.663533552653, 4823.445303790057, 4853.4418541867435, 4728.078024785168, 4750.714957102585, 4762.714237145748, 4773.904521909577, 4780.880477988043, 4681.859544213679, 4729.905401891977, 4762.28565715142, 4777.402824646919, 4818.4217893852965, 5387.922415516912, 5388.811391601275, 5390.487903649187, 5394.271773310631, 5399.83800485986, 5680.4319568043275, 5744.195812586241, 5757.712114394305, 5826.679532625704, 5845.152452894349, 5875.8531036724, 5881.500072493843, 5887.175795388649, 5892.970535147339, 5918.260217472816, 5399.83800485986, 5421.891562168735, 5424.159255315432, 5433.701146436944, 5434.2935418395355, 5900.704964751745, 5983.102534619842, 5986.191864098291, 5990.161377407167, 6014.609050411709, 5672.971635141798, 5689.345725241567, 5715.657060576379, 5720.056190728483, 5721.199032135504, 5778.6821724804695, 5784.623999440023, 5808.07070868659, 5816.88366232673, 5817.0, 5615.0454422748235, 5702.087665973424, 5703.7148142592705, 5707.514861236841, 5725.398833122462, 5696.3733989261145, 5706.115552089433, 5708.885822283531, 5709.857253568694, 5718.885622287614, 4683.648726345537, 4759.524047595212, 4781.784819683123, 4827.106985207748, 4853.19922212838, 4125.381192821101, 4138.958610413918, 4145.274576949022, 4173.770442625685, 4189.224993376235, 4807.302941073524, 4895.0, 4899.559039686445, 4901.43633482147, 4946.08497427977, 5653.547716182696, 5721.942780572224, 5788.681622510718, 5820.330661973927, 5841.88316233673, 4831.0820944020525, 4890.168671325812, 4919.532644398776, 4924.212126059813, 4933.45731969483, 5158.252053452228, 5174.689518628894, 5181.896362072813, 5185.974070129625, 5220.608454365938, 5283.128283833278, 5357.732113394237, 5378.139497680352, 5405.270288511001, 5448.264484294569, 5781.566382521243, 5786.6528008317955, 5786.884262314646, 5788.739506722123, 5790.739416726173, 5233.267342571967, 5287.365516138088, 5324.9733751331, 5340.412554618911, 5392.406835248198, 5718.828435146952, 5760.423957604374, 5806.5645076618575, 5823.621464604787, 5827.213326200908, 5726.79956201531, 5870.55970802183, 5875.794347197828, 5882.49998750111, 5884.941150588439, 5535.114381698909, 5624.268845050117, 5628.74670639814, 5634.126710359901, 5674.574406919415, 5632.0, 5647.124695672177, 5647.491725744702, 5655.208270842168, 5686.573506987075, 5557.805476808292, 5577.358603760619, 5583.0, 5595.524380427709, 5599.720013999366, 5569.944300556943, 5639.887202256014, 5668.943310567007, 5677.063284558001, 5724.771009159587, 5418.729063546885, 5425.511703946664, 5426.240326354393, 5445.237666726583, 5540.944590554042], "value": 5242.830850549835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7843697831803, 637.9425851673349, 658.1969996604145, 1186.2467333243394, 1190.3393616542826, 34588.4811727824, 35003.299934001305, 35280.70675406097, 35413.46879796805, 35450.0, 33426.33147337052, 34203.82898085512, 34222.31555368891, 34229.48655770165, 34282.14294642635, 6887.586744795316, 7046.929530704704, 7050.189228238742, 7052.025432878777, 7053.224145344008, 6820.147481564804, 6872.587644741331, 6925.030495730602, 6930.72277108915, 6952.617606031667, 6863.382295593396, 6931.653417329138, 6947.235804061549, 6961.408280296181, 6964.860702785942, 6868.896966545506, 6889.689963951634, 6920.653967301665, 6956.965215173942, 6967.512274140812, 6821.965890170517, 6892.483063770237, 6908.274631163756, 6909.412699920513, 6919.204291506491, 32047.359052818814, 32220.516692249636, 32244.0, 32278.515822262685, 32362.352752945044, 3066.1874603230162, 3094.9690503094907, 3096.5974423324824, 3105.1460848266684, 3108.036508682316, 24443.26670199879, 24515.0, 24527.141550045664, 24555.38611534708, 24591.0, 2984.4627966965936, 3015.517517197238, 3034.544818277254, 3038.969610303891, 3041.148478426022, 144080.0, 144151.0, 144324.0, 151887.0, 154441.0, 39346.40980385296, 39691.0, 39781.40327895084, 39947.2010559793, 39963.40054899179, 42108.15783684309, 42122.15755684869, 45071.77464112724, 45446.63660090203, 45461.318080228826, 10986.890131098746, 11132.777344453227, 11134.3876086816, 11149.498272577754, 11153.0, 8690.04409514953, 8710.259627931697, 8718.86921696175, 8735.301175905912, 8740.21338079576, 12951.546695865787, 12972.740545189232, 12999.67079338789, 13069.085164038426, 13158.802617960739, 5366.436524164907, 5370.409254981949, 5460.945390546044, 5573.359063707644, 5577.9163312550345, 796.7610365880995, 815.8980127484065, 848.4061157189992, 849.1720572441819, 855.922966932979, 19096.361455417944, 19366.800769634312, 20002.199912003358, 20051.097700603506, 20406.69389959152, 925.9906003971398, 948.5399581203111, 974.5078735238659, 975.2100798353357, 980.8626792249091, 10848.620298289521, 11052.226344155994, 11290.830637540443, 11307.0, 11453.942730286462, 174956.0, 175757.0, 175762.0, 175874.0, 176936.0, 40935.0, 41275.793621031706, 41368.37947430791, 41399.1720165595, 41455.79272103681, 1180.959392706318, 1220.4507971413077, 1226.9877301226873, 1237.9876201238053, 1249.900007999358, 19338.226470941005, 19947.401577952685, 20620.484487887923, 20644.896775516027, 20821.791782081986, 29577.85211074017, 29587.408251835273, 29628.407431851672, 29780.553291701075, 29830.0, 156241.0, 157233.0, 158144.0, 158372.0, 158521.0, 28678.13965581036, 28844.855775720986, 29072.273193169494, 29092.854535727187, 29140.0, 34515.654843451244, 34538.30923381468, 34856.47715284222, 35516.644833551334, 35919.64080359163, 25308.62037069482, 26237.606435903093, 26932.0, 27049.323766905985, 27505.449891002467, 26296.0, 26943.776022685324, 26951.595726064515, 27844.44311113807, 28273.293167670974, 30442.39115217639, 30518.237044074074, 30519.0, 30562.388752225277, 30591.388172236875, 25184.49631007406, 26091.60862587025, 26453.206403807915, 26745.86627066852, 26959.0, 20040.298589549297, 21801.781982180608, 21968.681879087308, 22246.555068898208, 22269.220577279717], "value": 14323.093981656944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.1183971583088, 400.6714494114827, 402.9073313137979, 403.92325458162946, 429.4974879391112, 14418.134911905294, 15246.00900941438, 17178.570535736613, 18000.72998905016, 18046.0, 17129.657406851857, 17414.129293535338, 17867.463976080737, 19118.13968371423, 19424.805751942476, 5271.973640131794, 5332.760025798839, 5392.272043274166, 5549.0289199390145, 5555.472230138151, 5245.318108645871, 5292.497212764782, 5313.203019547061, 5335.466453354672, 5340.332458442695, 5214.739263036833, 5444.700541470217, 5455.727213639322, 5468.234447177399, 5488.506034456898, 5353.919691204615, 5365.275687782138, 5374.973125134369, 5406.405295417501, 5432.864178395532, 4765.714057156547, 4835.419749630032, 4866.075445665312, 4866.878328041792, 4872.951270487285, 21952.780472195394, 22079.0, 22124.668129978065, 22690.773092269195, 22884.084636614516, 1629.551873234858, 1678.0, 1679.6388776413007, 1679.7984241891052, 1688.5272123805355, 14496.710065798625, 14541.34563944625, 14952.551423457206, 15210.923945380202, 15254.847451525453, 2003.4190084875368, 2050.3746357361, 2067.359118673216, 2129.4144110369616, 2131.4032071020138, 83181.42502162379, 85064.57467712683, 87307.56346218228, 87376.25247495015, 89661.10338896593, 10431.321964072311, 10845.891541084646, 10848.240623156304, 10899.1280697544, 11050.171237157245, 14887.0, 14922.418619531234, 14946.32741526634, 14955.925220374045, 14966.17686027279, 7156.069710937545, 7180.210176880539, 7380.261973802684, 7451.701931922662, 7480.251974802585, 6566.080748695186, 6605.768798092044, 6643.136392269071, 6834.965825170842, 6835.624040677711, 6891.277180704824, 6910.516263861481, 6986.685599148051, 7107.573545587281, 7119.288071192839, 1896.0, 1906.752122224102, 1908.8759230649964, 1913.7033759767257, 1986.5430950881089, 829.9875501867476, 853.0744142605342, 865.2040123086775, 886.0342226972631, 892.0945240580816, 17080.658386832194, 17279.91360043192, 17419.47741567755, 17712.822871771376, 18004.459866204033, 853.3727710133047, 859.8495263328892, 870.5766072471428, 873.0, 890.7283278599959, 9366.29752768545, 9566.13904748576, 9717.17404020666, 9788.412695238309, 9862.50687465624, 308392.0, 308530.0, 310095.0, 312204.0, 314349.0, 72328.27671723215, 72578.0, 72715.63642181756, 74186.62906685432, 74416.62791686007, 1006.8453509489698, 1028.89711028898, 1031.046282188972, 1049.2812423489934, 1099.725068732817, 16144.838551614333, 18800.62398752045, 18935.621287574446, 18992.145353459404, 19195.712064319327, 40039.79980100081, 40656.39015414831, 41026.0, 41362.79318603388, 42316.36525452059, 51526.48473515217, 51981.22028169656, 52976.73511632417, 54355.72822135864, 55115.1106111736, 12105.455254513745, 12444.937775311066, 12457.252564846138, 12488.562900298446, 12513.311767852856, 13572.524961626295, 13641.658958526115, 13702.52041178554, 13799.2410417428, 13896.51362202318, 11487.483063262007, 11528.59649912249, 11708.765824683629, 11814.468348924147, 12068.39658017078, 10337.17302615804, 10432.791344173225, 10433.26967112295, 10483.108935740242, 10538.57845686164, 11663.066954643778, 11818.0, 11851.170418070653, 12349.073819463756, 12391.93804030974, 12264.38678066111, 12292.446839892047, 12453.879150876464, 12544.686382840502, 12763.872361276268, 11206.38364889939, 11536.36549989725, 11679.299242045505, 11755.0, 12092.455839487067], "value": 9011.703880494348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1208.25088445164, 1272.7645385603664, 1282.8845403913647, 1283.6854970532222, 1286.4018231522346, 9718.757031074218, 9882.604695812177, 10061.446620435881, 10104.393736375823, 10171.84742228867, 9880.703578892644, 10086.798264034715, 10100.0, 10167.847482287772, 10189.643362482297, 2211.3144925073198, 2245.7305123385217, 2251.549690061986, 2252.6170551006285, 2263.54729054189, 2124.1184908263053, 2187.628103222448, 2189.080586153811, 2192.5286063496346, 2193.0679461228992, 2162.4701948022757, 2163.8593491423085, 2198.2635817001324, 2201.218567408571, 2210.071769856656, 2059.8970051497367, 2079.365793433002, 2096.6854971754206, 2097.569998150383, 2108.0303060592146, 2057.351934140741, 2088.95822083559, 2138.7540432850265, 2173.0873033326043, 2193.8793366364844, 9880.90119098807, 9883.357581757164, 9896.653617123366, 9947.25395595326, 9961.750956226153, 5298.788048478056, 5463.808766693147, 5467.753951072172, 5468.507834294933, 5468.945310546884, 2985.9701402986125, 3188.9362212755614, 3256.1208473711963, 3259.788113772597, 3270.6565810590023, 993.0764389118117, 1027.5016616940777, 1041.0838462153256, 1050.4747626186906, 1050.5745173204864, 13895.235762033084, 14143.787843182257, 14146.36341364641, 14154.575362739031, 14176.716465670732, 4523.11799199153, 4561.657875659273, 4719.244920812654, 4817.301491283814, 4830.734309613005, 10170.745731356626, 10223.386596804066, 10226.0, 10267.897321026843, 10311.587536498457, 5384.596155288369, 5398.64908780928, 5411.702356370359, 5427.674339539641, 5435.402105768362, 4891.413030436371, 5038.974805126024, 5043.142665746832, 5059.62052846038, 5064.569511591482, 3560.964390356063, 3588.372034893883, 3623.1304486923477, 3646.8176591170336, 3724.2179142380405, 1073.6617965340893, 1075.2688172042929, 1080.5461706083306, 1095.4194277033184, 1107.8836722144058, 718.8849784034529, 738.7155944961229, 741.855338209044, 743.8177646476648, 755.2296657409412, 5379.704116273564, 5449.945500544944, 5500.339959204841, 5572.3870374258795, 5588.245586845724, 512.9974350128225, 551.7599844067844, 554.7864072332101, 555.5666580067553, 565.0366125755659, 3285.704286614216, 3844.1350696093155, 3976.8608098716404, 3992.680585553149, 3998.3202855514633, 11511.30932144074, 12316.938415307866, 12684.492620295085, 12698.80951785724, 12702.745945081047, 12093.093018023683, 12098.153129281041, 12385.814212786816, 12537.623871283877, 12605.495780168874, 7007.789766306917, 7127.786166415016, 7128.394086502705, 7143.392811611071, 7155.248698886646, 5793.797217097382, 5833.387494313206, 5893.970530147493, 5906.232189815297, 6008.399160083956, 11047.447627618747, 11198.38408887519, 11217.102631789274, 11378.658640240476, 11522.0, 11548.538058477567, 11563.248388855034, 11611.0, 11626.0, 11737.237079589799, 7818.765437036898, 8021.799455013671, 8066.637001335072, 8160.26557609818, 8172.101068882299, 9125.863112053192, 9298.302627303116, 9319.254459643347, 9320.440773553608, 9322.394044387092, 7920.287174154354, 7924.28681418652, 8133.2680058794995, 8234.711785087493, 8308.70919517814, 7556.395488361028, 7898.328642065489, 7959.0, 7960.562169080525, 8191.467554608931, 7065.505414621133, 7300.963495182703, 7343.155537113087, 7350.411967042731, 7360.705571777069, 4797.280407938837, 5346.625736198429, 5394.865128371822, 5573.1918871762555, 5694.487496125369, 5118.181091025418, 5132.230165475208, 5153.123968925367, 5159.251908473326, 5369.785208591768], "value": 4563.584519357351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6459305287766, 367.3772954841544, 372.92355067211224, 378.292592851368, 382.79520456555747, 5408.0, 5548.278723765905, 5609.775608975641, 5630.77476900924, 5644.447776861365, 5338.332708411449, 5420.756065977031, 5435.130379139338, 5453.563714902808, 5465.606270401042, 4106.876793696194, 4107.075907920709, 4111.588841115894, 4114.6296833285, 4116.176764647068, 4118.238125946709, 4132.421460995463, 4132.574261879662, 4182.560831112735, 4309.418228539154, 4304.859212308741, 4330.84842030529, 4333.761643109628, 4335.479742430897, 4341.39220509129, 4337.587929146726, 4338.84814031509, 4358.215521206197, 4361.978190109061, 4378.058717375748, 3843.7693738375506, 3920.705947053954, 3958.346872766019, 3978.2839088963974, 3979.900502487461, 5406.54044406226, 5416.891662166774, 5420.235679803329, 5424.674519528841, 5454.10007348787, 5120.743962801882, 5146.176611742103, 5156.458571849939, 5162.883217880689, 5165.22521621756, 5838.065909454467, 5842.853928651775, 5843.211166492511, 5866.354700982888, 5905.055191169392, 4387.815289871749, 4401.22978478765, 4426.207386008672, 4427.535108813592, 4438.800253988546, 5964.1650168976375, 6142.692865356715, 6196.163517925068, 6218.28489723683, 6247.781327653511, 4277.636400905958, 4279.636230920344, 4295.6778241632, 4299.9570004300185, 4299.9570004300185, 4333.371661109121, 4342.435483387139, 4346.543612920661, 4363.4109395231235, 4385.693001489865, 4951.579115775199, 4957.975210123998, 4971.975140124277, 5102.821401250939, 5138.332016837787, 5877.118432235199, 5889.322727886262, 5898.1715668143015, 5900.822975310662, 5901.40985901415, 1594.9122798246208, 1612.9919350403172, 1619.6031972166895, 1627.1620115640455, 1628.210317995771, 1125.6960620632547, 1158.1892675127276, 1160.976780464386, 1163.3252713426193, 1166.6208482243305, 5029.949700502948, 5030.144875371196, 5036.622253331015, 5040.7731652075745, 5049.166887463527, 6037.335893051761, 6066.939330606726, 6083.482903953125, 6090.573659843857, 6103.877922441527, 4812.663113582085, 4984.950150498521, 5019.121653710586, 5062.696238225718, 5086.54221120101, 3170.889018884328, 3190.6171259449015, 3207.615086189672, 3222.113918672337, 3224.339010502841, 5471.316085489314, 5592.105263157957, 5596.636218645775, 5630.23991761107, 5659.575531835047, 6185.165002724664, 6213.161223234896, 6225.470834978987, 6233.563650544509, 6243.594166379171, 5557.194206840067, 5613.607047506635, 5617.691026993554, 5639.915401268984, 5650.576206784425, 5991.700414979146, 5999.640021598718, 6051.0, 6051.092336149437, 6060.030395136757, 5825.271841019872, 5871.559633027455, 5943.851403714942, 5945.40545945402, 5955.612885162624, 5607.2149899014985, 5638.464345887134, 5667.914981275367, 5686.857828554319, 5687.744051517609, 4064.1871625675576, 4079.7960101995377, 4090.1798699578403, 4097.549269580403, 4098.6516146127915, 5994.970025149846, 6063.878722425438, 6116.969415152896, 6157.4458298753325, 6163.784267550794, 5896.64620122794, 5897.557683173865, 5906.438888305604, 5910.586258961831, 5918.964181268175, 5743.253377060955, 5821.679807610622, 5866.970665146647, 5893.44012318829, 5914.112883067574, 5705.771769129188, 5770.682612456355, 5777.2200752897825, 5789.652620842763, 5840.0, 5902.38025007368, 5902.61632993854, 5912.645241285537, 5920.993431116634, 5931.0, 5600.383957764561, 5675.205471233948, 5705.828825135252, 5711.143328500592, 5718.828435146952], "value": 4445.920878318455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7455553278583, 734.9816254593635, 749.7038669725458, 760.2815339504167, 761.330029573975, 12230.571929982452, 12799.680007999781, 13199.604011879635, 13943.721125577482, 13971.022028458012, 15104.244787760623, 15520.922395388036, 15665.608359791011, 15677.84322156778, 15704.764428533581, 909.7452713240286, 918.912703293186, 921.1801496667971, 922.4511415707643, 923.2291036984126, 898.6046139698511, 901.2159421303476, 901.378049146087, 902.9503377314245, 904.751193421811, 963.4075043848018, 969.4522594733988, 969.5346233807777, 970.7039352997333, 973.7711637765119, 957.1624828275259, 960.1454705312277, 961.3703024518917, 962.9229661627053, 963.59047404853, 709.5139829216952, 710.1513691139091, 711.4130842055325, 712.0600806934848, 712.8039789057999, 13956.371963261678, 14370.568882933425, 14430.0, 14572.854271457256, 14609.123452592772, 15057.54827355181, 15490.148041857694, 15612.843871561367, 15800.36798528069, 16163.111028893407, 11457.083433325313, 11570.247933884271, 11721.94139029308, 11797.29216247028, 11917.344546049964, 2980.3145276586506, 2984.3136078701805, 2993.5659329397117, 3002.6697063323236, 3011.1719277198727, 71776.0, 71920.99999999948, 72736.27263727348, 73614.63192684056, 75144.24855751482, 12485.063620228337, 12638.684032899067, 12657.620271391874, 12674.176178548365, 12687.429065692066, 21553.0, 22630.547389052455, 22643.20748773785, 22647.547049058925, 22852.65721014186, 5868.882622347529, 6065.6663883486835, 6093.512518998469, 6097.024476083805, 6115.1744514490865, 2759.613654088429, 2798.664160300777, 2804.6774620918445, 2809.283632673655, 2812.578113282983, 3607.639236076424, 3688.704903607705, 3691.557013158438, 3862.9806850965565, 3972.741771784825, 740.1857956248192, 759.4835511851994, 765.9042619672541, 769.7767647382309, 774.4656187230793, 575.6517307029271, 579.4147910610313, 589.7699897040158, 602.1599868183858, 608.2184393054991, 9124.95437522808, 9567.234621230285, 9835.0, 9997.200223982063, 10544.367337959748, 562.3139769481227, 572.5190839694676, 573.5554944917723, 579.0532479396218, 583.8015074874563, 4353.695241333076, 4542.091581683677, 4572.428446444194, 4583.770811459413, 4715.669903106749, 51248.74375628098, 52645.473545264824, 54202.0, 55169.0, 56565.0, 48926.510734892196, 49201.753991229816, 49336.25995610069, 49472.01055978932, 49777.50222497801, 44257.557424425344, 46716.0, 46797.06405871932, 47608.76195619, 48049.0, 9879.753006174904, 10514.57941682324, 10633.308834925705, 10842.566297348018, 11024.779504410028, 24336.0, 24625.29121796637, 24667.50664986726, 25225.11712090068, 25696.100636477633, 40563.39154912738, 41955.7902210487, 42528.787356063025, 42964.35553466638, 43999.340009899235, 14274.357653905807, 14474.34865431037, 14612.123272603678, 14720.631984200052, 14939.925300373428, 13566.59300220995, 13844.792328114885, 15428.30572624212, 15453.768193477332, 15835.049897006216, 14308.141511509342, 14557.34491947886, 14646.26768661584, 14710.485133020293, 14911.850881491046, 13060.346982651019, 13666.52167174144, 13708.725825483236, 14069.226192559507, 14329.283535822959, 13766.31168441594, 14364.425422982964, 14583.125012499284, 14709.117452952856, 14864.331105100513, 10601.25791194609, 10949.83575246356, 11015.944920275348, 11096.33421994683, 11175.49710263024, 10911.618093366695, 10949.288296260718, 11085.889141108486, 11331.263467874562, 11352.091832653534], "value": 6828.850786245798, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 111.0, 112.0, 114.0, 113.0, 111.0, 116.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 124.0, 181.0, 128.0, 128.0, 123.0, 126.0, 147.0, 124.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 163.0, 161.0, 163.0, 167.0, 166.0, 162.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 108.0, 75.0, 76.0, 75.0, 76.0, 101.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 85.0, 84.0, 83.0, 96.0, 86.0, 85.0, 107.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 115.0, 114.0, 114.0, 114.0, 113.0, 115.0, 115.0, 114.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 152.0, 150.0, 151.0, 155.0, 153.0, 153.0, 150.0, 150.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 55.0, 59.0, 58.0, 55.0, 56.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 59.0, 59.0, 56.0, 56.0, 56.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 82.0, 94.0, 81.0, 83.0, 83.0, 84.0, 82.0, 92.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 141.0, 141.0, 134.0, 150.0, 136.0, 130.0, 184.0, 137.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 194.0, 182.0, 192.0, 195.0, 189.0, 201.0, 189.0, 190.0, 196.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 74.0, 74.0, 74.0, 77.0, 73.0, 73.0], "value": 74.3, "unit": "score"}]}]} 21:33:10 INFO - Return code: 0 21:33:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:33:10 INFO - # TBPL SUCCESS # 21:33:10 INFO - Running post-action listener: _resource_record_post_action 21:33:10 INFO - [mozharness: 2017-05-22 04:33:10.783652Z] Finished run-tests step (success) 21:33:10 INFO - Running post-run listener: _resource_record_post_run 21:33:10 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 339968; Write bytes: 426622976; Read time: 148; Write time: 396988 21:33:10 INFO - TinderboxPrint: CPU usage
13.3% 21:33:10 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 148 21:33:10 INFO - TinderboxPrint: I/O write bytes / time
426,622,976 / 396,988 21:33:10 INFO - TinderboxPrint: CPU idle
8,298.0 (86.6%) 21:33:10 INFO - TinderboxPrint: CPU user
1,221.6 (12.8%) 21:33:10 INFO - TinderboxPrint: Swap in / out
0 / 0 21:33:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109211648; Read time: 44; Write time: 129864 21:33:10 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 335872; Write bytes: 317411328; Read time: 104; Write time: 267124 21:33:11 INFO - Running post-run listener: _upload_blobber_files 21:33:11 INFO - Blob upload gear active. 21:33:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:33:11 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 21:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:33:11 INFO - (blobuploader) - INFO - Open directory for files ... 21:33:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:33:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:12 INFO - (blobuploader) - INFO - Done attempting. 21:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:33:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:18 INFO - (blobuploader) - INFO - Done attempting. 21:33:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:33:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:33:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:20 INFO - (blobuploader) - INFO - Done attempting. 21:33:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:33:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:33:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:33:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:33:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:33:20 INFO - (blobuploader) - INFO - Done attempting. 21:33:20 INFO - (blobuploader) - INFO - Iteration through files over. 21:33:20 INFO - Return code: 0 21:33:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:33:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:33:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48bdff6dfc150021aeee686cde18929226e18b8c8a95a5896bfa768b7fc816df7bd73b3eda678f17625e77fa8d8c0663dde6ce8603680de6c1cc7e3bc06776e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dca8feb2d6c2d8be25cacfdac4aba44caeea1e4cbec6c5d05ec129e9b7eecf3ea557d454a3bcbe8d6656c5b7966985d9ed9f619b18603592282efa02c041b772", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c41491b1b3d42b5e497d247f5d067fc662b49f55f769a6e613fece7ddcbc71358df1c7e72417d39853ec6001f57f376449dbd78d21d95fad47d15f2481127d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4bf3152b2c95a6dd65b36d50e279f51216e559c7d3ff6642d3b61997e4b6f8bbfb6809b6dc9fcfa0af2e80a77ecfe699e1a6ced7996ca3f7fca25dfb175fb9"} 21:33:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:33:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:33:20 INFO - Contents: 21:33:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48bdff6dfc150021aeee686cde18929226e18b8c8a95a5896bfa768b7fc816df7bd73b3eda678f17625e77fa8d8c0663dde6ce8603680de6c1cc7e3bc06776e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dca8feb2d6c2d8be25cacfdac4aba44caeea1e4cbec6c5d05ec129e9b7eecf3ea557d454a3bcbe8d6656c5b7966985d9ed9f619b18603592282efa02c041b772", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c41491b1b3d42b5e497d247f5d067fc662b49f55f769a6e613fece7ddcbc71358df1c7e72417d39853ec6001f57f376449dbd78d21d95fad47d15f2481127d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4bf3152b2c95a6dd65b36d50e279f51216e559c7d3ff6642d3b61997e4b6f8bbfb6809b6dc9fcfa0af2e80a77ecfe699e1a6ced7996ca3f7fca25dfb175fb9"} 21:33:20 INFO - Running post-run listener: copy_logs_to_upload_dir 21:33:20 INFO - Copying logs to upload dir... 21:33:20 INFO - mkdir: /builds/slave/test/build/upload/logs 21:33:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.806007 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-21 21:33:20.882211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 21:33:20.889005) ========= 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=17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943 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/sha512/48bdff6dfc150021aeee686cde18929226e18b8c8a95a5896bfa768b7fc816df7bd73b3eda678f17625e77fa8d8c0663dde6ce8603680de6c1cc7e3bc06776e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dca8feb2d6c2d8be25cacfdac4aba44caeea1e4cbec6c5d05ec129e9b7eecf3ea557d454a3bcbe8d6656c5b7966985d9ed9f619b18603592282efa02c041b772", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c41491b1b3d42b5e497d247f5d067fc662b49f55f769a6e613fece7ddcbc71358df1c7e72417d39853ec6001f57f376449dbd78d21d95fad47d15f2481127d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4bf3152b2c95a6dd65b36d50e279f51216e559c7d3ff6642d3b61997e4b6f8bbfb6809b6dc9fcfa0af2e80a77ecfe699e1a6ced7996ca3f7fca25dfb175fb9"} build_url:https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/CloPmkbsR3-4P0-9HKO0qg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/48bdff6dfc150021aeee686cde18929226e18b8c8a95a5896bfa768b7fc816df7bd73b3eda678f17625e77fa8d8c0663dde6ce8603680de6c1cc7e3bc06776e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dca8feb2d6c2d8be25cacfdac4aba44caeea1e4cbec6c5d05ec129e9b7eecf3ea557d454a3bcbe8d6656c5b7966985d9ed9f619b18603592282efa02c041b772", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c41491b1b3d42b5e497d247f5d067fc662b49f55f769a6e613fece7ddcbc71358df1c7e72417d39853ec6001f57f376449dbd78d21d95fad47d15f2481127d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4bf3152b2c95a6dd65b36d50e279f51216e559c7d3ff6642d3b61997e4b6f8bbfb6809b6dc9fcfa0af2e80a77ecfe699e1a6ced7996ca3f7fca25dfb175fb9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 21:33:20.913945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:33:20.914241) ========= 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=17051fcd5208b27b50bedfeb000001dd-1495426337.978885-5517943 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:33:20.996170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 21:33:20.996464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 21:33:20.999768) ========= ========= Total master_lag: 0.17 =========